builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1481817544.04 results: success (0) buildid: 20161215061212 builduid: 16f5c38f3be64ead8dea092e94972c98 revision: c750a7de1194d71f2d2ef73f6a919d26b9640cae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:04.036916) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:04.037925) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:04.038382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:04.113442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:04.113796) ========= 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=03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 07:59:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-12-15 07:59:04 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145282 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:04.291039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:04.291371) ========= 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=03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.089038 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:04.390560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:04.390925) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c750a7de1194d71f2d2ef73f6a919d26b9640cae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c750a7de1194d71f2d2ef73f6a919d26b9640cae --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=03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 07:59:04,462 truncating revision to first 12 chars 2016-12-15 07:59:04,462 Setting DEBUG logging. 2016-12-15 07:59:04,462 attempt 1/10 2016-12-15 07:59:04,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c750a7de1194?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 07:59:04,975 unpacking tar archive at: mozilla-central-c750a7de1194/testing/mozharness/ program finished with exit code 0 elapsedTime=0.806228 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:05.210757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:05.211077) ========= script_repo_revision: c750a7de1194d71f2d2ef73f6a919d26b9640cae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:05.211491) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:05.211758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 07:59:05.220662) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-15 07:59:05.221134) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:59:05 INFO - MultiFileLogger online at 20161215 07:59:05 in /builds/slave/test 07:59:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:59:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:59:05 INFO - {'append_to_log': False, 07:59:05 INFO - 'base_work_dir': '/builds/slave/test', 07:59:05 INFO - 'blob_upload_branch': 'Firefox', 07:59:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:59:05 INFO - 'branch': 'Firefox', 07:59:05 INFO - 'buildbot_json_path': 'buildprops.json', 07:59:05 INFO - 'config_files': ('talos/linux_config.py',), 07:59:05 INFO - 'default_actions': ('clobber', 07:59:05 INFO - 'read-buildbot-config', 07:59:05 INFO - 'download-and-extract', 07:59:05 INFO - 'populate-webroot', 07:59:05 INFO - 'create-virtualenv', 07:59:05 INFO - 'install', 07:59:05 INFO - 'run-tests'), 07:59:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:59:05 INFO - 'download_minidump_stackwalk': True, 07:59:05 INFO - 'download_symbols': 'ondemand', 07:59:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:59:05 INFO - 'tooltool.py': '/tools/tooltool.py', 07:59:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:59:05 INFO - '/tools/misc-python/virtualenv.py')}, 07:59:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:59:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:59:05 INFO - 'installer_path': 'installer.exe', 07:59:05 INFO - 'log_level': 'info', 07:59:05 INFO - 'log_name': 'talos', 07:59:05 INFO - 'log_to_console': True, 07:59:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:59:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:59:05 INFO - 'opt_config_files': (), 07:59:05 INFO - 'pip_index': False, 07:59:05 INFO - 'sps_profile': False, 07:59:05 INFO - 'sps_profile_interval': 0, 07:59:05 INFO - 'suite': 'dromaeojs', 07:59:05 INFO - 'system_bits': '32', 07:59:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:59:05 INFO - 'title': 'talos-linux64-ix-047', 07:59:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:59:05 INFO - 'use_talos_json': True, 07:59:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:59:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:59:05 INFO - 'work_dir': 'build'} 07:59:05 INFO - [mozharness: 2016-12-15 15:59:05.495475Z] Running clobber step. 07:59:05 INFO - Running pre-action listener: _resource_record_pre_action 07:59:05 INFO - Running main action method: clobber 07:59:05 INFO - rmtree: /builds/slave/test/build 07:59:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:59:06 INFO - Running post-action listener: _resource_record_post_action 07:59:06 INFO - [mozharness: 2016-12-15 15:59:06.433036Z] Finished clobber step (success) 07:59:06 INFO - [mozharness: 2016-12-15 15:59:06.433189Z] Running read-buildbot-config step. 07:59:06 INFO - Running pre-action listener: _resource_record_pre_action 07:59:06 INFO - Running main action method: read_buildbot_config 07:59:06 INFO - Using buildbot properties: 07:59:06 INFO - { 07:59:06 INFO - "project": "", 07:59:06 INFO - "product": "firefox", 07:59:06 INFO - "script_repo_revision": "production", 07:59:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:59:06 INFO - "repository": "", 07:59:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:59:06 INFO - "buildid": "20161215061212", 07:59:06 INFO - "stage_platform": "linux64-pgo", 07:59:06 INFO - "basedir": "/builds/slave/test", 07:59:06 INFO - "nightly_build": "True", 07:59:06 INFO - "buildnumber": 131, 07:59:06 INFO - "slavename": "talos-linux64-ix-047", 07:59:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:59:06 INFO - "platform": "ubuntu64_hw", 07:59:06 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:59:06 INFO - "branch": "mozilla-central", 07:59:06 INFO - "repo_path": "mozilla-central", 07:59:06 INFO - "revision": "c750a7de1194d71f2d2ef73f6a919d26b9640cae", 07:59:06 INFO - "pgo_build": "True", 07:59:06 INFO - "builduid": "16f5c38f3be64ead8dea092e94972c98", 07:59:06 INFO - "slavebuilddir": "test" 07:59:06 INFO - } 07:59:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:59:06 INFO - Running post-action listener: _resource_record_post_action 07:59:06 INFO - [mozharness: 2016-12-15 15:59:06.437171Z] Finished read-buildbot-config step (success) 07:59:06 INFO - [mozharness: 2016-12-15 15:59:06.437339Z] Running download-and-extract step. 07:59:06 INFO - Running pre-action listener: _resource_record_pre_action 07:59:06 INFO - Running main action method: download_and_extract 07:59:06 INFO - mkdir: /builds/slave/test/build/tests 07:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:06 INFO - trying https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:59:06 INFO - Downloading https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:59:07 INFO - Downloaded 1361 bytes. 07:59:07 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:59:07 INFO - Using the following test package requirements: 07:59:07 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:59:07 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:59:07 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:59:07 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:07 INFO - u'jsshell-linux-x86_64.zip'], 07:59:07 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:59:07 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:59:07 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:59:07 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:59:07 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:59:07 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:59:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:59:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:59:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:59:07 INFO - Fetch https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:59:07 INFO - Expected file size: 21776058 07:59:07 INFO - Obtained file size: 21776058 07:59:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:59:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:59:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:59:12 INFO - Fetch https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:59:12 INFO - Expected file size: 21776058 07:59:12 INFO - Obtained file size: 21776058 07:59:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:59:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:59:17 INFO - Fetch https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:59:18 INFO - Expected file size: 14409734 07:59:18 INFO - Obtained file size: 14409734 07:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:18 INFO - trying https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:59:18 INFO - Downloading https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:59:20 INFO - Downloaded 59780515 bytes. 07:59:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:59:20 INFO - mkdir: /builds/slave/test/properties 07:59:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:59:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:59:20 INFO - Contents: 07:59:20 INFO - build_url:https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:59:21 INFO - Running post-action listener: _resource_record_post_action 07:59:21 INFO - Running post-action listener: set_extra_try_arguments 07:59:21 INFO - [mozharness: 2016-12-15 15:59:21.623485Z] Finished download-and-extract step (success) 07:59:21 INFO - [mozharness: 2016-12-15 15:59:21.623712Z] Running populate-webroot step. 07:59:21 INFO - Running pre-action listener: _resource_record_pre_action 07:59:21 INFO - Running main action method: populate_webroot 07:59:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:59:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:59:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:59:21 INFO - '--tppagecycles', 07:59:21 INFO - '7'], 07:59:21 INFO - 'tests': ['tsvgm']}}, 07:59:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:59:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:59:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:59:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:59:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:59:21 INFO - 'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:59:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:59:21 INFO - 'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['damp', 'tps']}, 07:59:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:59:21 INFO - 'tests': ['damp', 'tps']}, 07:59:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['dromaeo_dom']}, 07:59:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:59:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['basic_compositor_video']}, 07:59:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:59:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['a11yr', 07:59:21 INFO - 'ts_paint', 07:59:21 INFO - 'tpaint', 07:59:21 INFO - 'sessionrestore', 07:59:21 INFO - 'sessionrestore_no_auto_restore', 07:59:21 INFO - 'tabpaint']}, 07:59:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:59:21 INFO - 'ts_paint', 07:59:21 INFO - 'tpaint', 07:59:21 INFO - 'sessionrestore', 07:59:21 INFO - 'sessionrestore_no_auto_restore', 07:59:21 INFO - 'tabpaint']}, 07:59:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:59:21 INFO - 'ts_paint', 07:59:21 INFO - 'tpaint', 07:59:21 INFO - 'sessionrestore', 07:59:21 INFO - 'sessionrestore_no_auto_restore', 07:59:21 INFO - 'tabpaint']}, 07:59:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:59:21 INFO - 'ts_paint', 07:59:21 INFO - 'tpaint', 07:59:21 INFO - 'sessionrestore', 07:59:21 INFO - 'sessionrestore_no_auto_restore', 07:59:21 INFO - 'tabpaint']}, 07:59:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['a11yr', 07:59:21 INFO - 'ts_paint', 07:59:21 INFO - 'tpaint', 07:59:21 INFO - 'sessionrestore', 07:59:21 INFO - 'sessionrestore_no_auto_restore', 07:59:21 INFO - 'tabpaint']}, 07:59:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['a11yr', 07:59:21 INFO - 'ts_paint', 07:59:21 INFO - 'tpaint', 07:59:21 INFO - 'sessionrestore', 07:59:21 INFO - 'sessionrestore_no_auto_restore', 07:59:21 INFO - 'tabpaint']}, 07:59:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['tsvgx', 07:59:21 INFO - 'tsvgr_opacity', 07:59:21 INFO - 'tart', 07:59:21 INFO - 'tscrollx', 07:59:21 INFO - 'cart', 07:59:21 INFO - 'tsvg_static']}, 07:59:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:59:21 INFO - 'tsvgr_opacity', 07:59:21 INFO - 'tart', 07:59:21 INFO - 'tscrollx', 07:59:21 INFO - 'cart', 07:59:21 INFO - 'tsvg_static']}, 07:59:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:59:21 INFO - 'talos_options': ['--disable-e10s'], 07:59:21 INFO - 'tests': ['tp5o']}, 07:59:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:59:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:59:21 INFO - 'talos_options': ['--disable-e10s', 07:59:21 INFO - '--xperf_path', 07:59:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:21 INFO - 'tests': ['tp5n']}, 07:59:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:59:21 INFO - 'talos_options': ['--xperf_path', 07:59:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:21 INFO - 'tests': ['tp5n']}}, 07:59:21 INFO - 'talos.zip': {'path': '', 07:59:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:59:21 INFO - Running post-action listener: _resource_record_post_action 07:59:21 INFO - [mozharness: 2016-12-15 15:59:21.642722Z] Finished populate-webroot step (success) 07:59:21 INFO - [mozharness: 2016-12-15 15:59:21.642809Z] Running create-virtualenv step. 07:59:21 INFO - Running pre-action listener: _resource_record_pre_action 07:59:21 INFO - Running main action method: create_virtualenv 07:59:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:59:21 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 07:59:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:59:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:59:21 INFO - Using real prefix '/usr' 07:59:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:59:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:59:24 INFO - Installing pip.................done. 07:59:24 INFO - Return code: 0 07:59:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:59:24 INFO - Reading from file tmpfile_stdout 07:59:24 INFO - Output received: 07:59:24 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) 07:59:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:24 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f30307fde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', '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 07:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 07:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:59:24 INFO - Using env: {'DISPLAY': ':0', 07:59:24 INFO - 'HOME': '/home/cltbld', 07:59:24 INFO - 'LANG': 'en_US.UTF-8', 07:59:24 INFO - 'LANGUAGE': 'en_US:en', 07:59:24 INFO - 'LOGNAME': 'cltbld', 07:59:24 INFO - 'MAIL': '/var/mail/cltbld', 07:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:24 INFO - 'MOZ_NO_REMOTE': '1', 07:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:24 INFO - 'NO_EM_RESTART': '1', 07:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:24 INFO - 'PWD': '/builds/slave/test', 07:59:24 INFO - 'SHELL': '/bin/bash', 07:59:24 INFO - 'SHLVL': '1', 07:59:24 INFO - 'TERM': 'linux', 07:59:24 INFO - 'TMOUT': '86400', 07:59:24 INFO - 'USER': 'cltbld', 07:59:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 07:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:24 INFO - '_': '/tools/buildbot/bin/python'} 07:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:25 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 07:59:25 INFO - Cleaning up... 07:59:25 INFO - Return code: 0 07:59:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:25 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f30307fde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', '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 07:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 07:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:59:25 INFO - Using env: {'DISPLAY': ':0', 07:59:25 INFO - 'HOME': '/home/cltbld', 07:59:25 INFO - 'LANG': 'en_US.UTF-8', 07:59:25 INFO - 'LANGUAGE': 'en_US:en', 07:59:25 INFO - 'LOGNAME': 'cltbld', 07:59:25 INFO - 'MAIL': '/var/mail/cltbld', 07:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:25 INFO - 'MOZ_NO_REMOTE': '1', 07:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:25 INFO - 'NO_EM_RESTART': '1', 07:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:25 INFO - 'PWD': '/builds/slave/test', 07:59:25 INFO - 'SHELL': '/bin/bash', 07:59:25 INFO - 'SHLVL': '1', 07:59:25 INFO - 'TERM': 'linux', 07:59:25 INFO - 'TMOUT': '86400', 07:59:25 INFO - 'USER': 'cltbld', 07:59:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 07:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:25 INFO - '_': '/tools/buildbot/bin/python'} 07:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:25 INFO - Downloading/unpacking psutil>=3.1.1 07:59:25 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 07:59:25 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 07:59:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:25 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 07:59:25 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 07:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:59:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:27 INFO - Installing collected packages: psutil 07:59:27 INFO - Running setup.py install for psutil 07:59:27 INFO - building 'psutil._psutil_linux' extension 07:59:27 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 07:59:28 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 07:59:28 INFO - building 'psutil._psutil_posix' extension 07:59:28 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 07:59:28 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 07:59:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:28 INFO - Successfully installed psutil 07:59:28 INFO - Cleaning up... 07:59:28 INFO - Return code: 0 07:59:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f30307fde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', '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 07:59:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 07:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:59:28 INFO - Using env: {'DISPLAY': ':0', 07:59:28 INFO - 'HOME': '/home/cltbld', 07:59:28 INFO - 'LANG': 'en_US.UTF-8', 07:59:28 INFO - 'LANGUAGE': 'en_US:en', 07:59:28 INFO - 'LOGNAME': 'cltbld', 07:59:28 INFO - 'MAIL': '/var/mail/cltbld', 07:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:28 INFO - 'MOZ_NO_REMOTE': '1', 07:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:28 INFO - 'NO_EM_RESTART': '1', 07:59:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:28 INFO - 'PWD': '/builds/slave/test', 07:59:28 INFO - 'SHELL': '/bin/bash', 07:59:28 INFO - 'SHLVL': '1', 07:59:28 INFO - 'TERM': 'linux', 07:59:28 INFO - 'TMOUT': '86400', 07:59:28 INFO - 'USER': 'cltbld', 07:59:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 07:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:28 INFO - '_': '/tools/buildbot/bin/python'} 07:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:59:31 INFO - Installing collected packages: mozsystemmonitor 07:59:31 INFO - Running setup.py install for mozsystemmonitor 07:59:31 INFO - Successfully installed mozsystemmonitor 07:59:31 INFO - Cleaning up... 07:59:31 INFO - Return code: 0 07:59:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:31 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f30307fde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', '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 07:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 07:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:59:31 INFO - Using env: {'DISPLAY': ':0', 07:59:31 INFO - 'HOME': '/home/cltbld', 07:59:31 INFO - 'LANG': 'en_US.UTF-8', 07:59:31 INFO - 'LANGUAGE': 'en_US:en', 07:59:31 INFO - 'LOGNAME': 'cltbld', 07:59:31 INFO - 'MAIL': '/var/mail/cltbld', 07:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:31 INFO - 'MOZ_NO_REMOTE': '1', 07:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:31 INFO - 'NO_EM_RESTART': '1', 07:59:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:31 INFO - 'PWD': '/builds/slave/test', 07:59:31 INFO - 'SHELL': '/bin/bash', 07:59:31 INFO - 'SHLVL': '1', 07:59:31 INFO - 'TERM': 'linux', 07:59:31 INFO - 'TMOUT': '86400', 07:59:31 INFO - 'USER': 'cltbld', 07:59:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 07:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:31 INFO - '_': '/tools/buildbot/bin/python'} 07:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:31 INFO - Downloading/unpacking jsonschema==2.5.1 07:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:59:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:59:33 INFO - warning: no files found matching '*.txt' 07:59:33 INFO - no previously-included directories found matching 'build' 07:59:33 INFO - no previously-included directories found matching 'dist' 07:59:33 INFO - no previously-included directories found matching '.git*' 07:59:33 INFO - Installing collected packages: jsonschema, functools32 07:59:33 INFO - Running setup.py install for functools32 07:59:34 INFO - warning: no files found matching '*.txt' 07:59:34 INFO - no previously-included directories found matching 'build' 07:59:34 INFO - no previously-included directories found matching 'dist' 07:59:34 INFO - no previously-included directories found matching '.git*' 07:59:34 INFO - Successfully installed jsonschema functools32 07:59:34 INFO - Cleaning up... 07:59:34 INFO - Return code: 0 07:59:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f30307fde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', '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 07:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 07:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:59:34 INFO - Using env: {'DISPLAY': ':0', 07:59:34 INFO - 'HOME': '/home/cltbld', 07:59:34 INFO - 'LANG': 'en_US.UTF-8', 07:59:34 INFO - 'LANGUAGE': 'en_US:en', 07:59:34 INFO - 'LOGNAME': 'cltbld', 07:59:34 INFO - 'MAIL': '/var/mail/cltbld', 07:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:34 INFO - 'MOZ_NO_REMOTE': '1', 07:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:34 INFO - 'NO_EM_RESTART': '1', 07:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:34 INFO - 'PWD': '/builds/slave/test', 07:59:34 INFO - 'SHELL': '/bin/bash', 07:59:34 INFO - 'SHLVL': '1', 07:59:34 INFO - 'TERM': 'linux', 07:59:34 INFO - 'TMOUT': '86400', 07:59:34 INFO - 'USER': 'cltbld', 07:59:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 07:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:34 INFO - '_': '/tools/buildbot/bin/python'} 07:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:59:34 INFO - Cleaning up... 07:59:34 INFO - Return code: 0 07:59:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f30307fde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', '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 07:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 07:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:59:34 INFO - Using env: {'DISPLAY': ':0', 07:59:34 INFO - 'HOME': '/home/cltbld', 07:59:34 INFO - 'LANG': 'en_US.UTF-8', 07:59:34 INFO - 'LANGUAGE': 'en_US:en', 07:59:34 INFO - 'LOGNAME': 'cltbld', 07:59:34 INFO - 'MAIL': '/var/mail/cltbld', 07:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:34 INFO - 'MOZ_NO_REMOTE': '1', 07:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:34 INFO - 'NO_EM_RESTART': '1', 07:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:34 INFO - 'PWD': '/builds/slave/test', 07:59:34 INFO - 'SHELL': '/bin/bash', 07:59:34 INFO - 'SHLVL': '1', 07:59:34 INFO - 'TERM': 'linux', 07:59:34 INFO - 'TMOUT': '86400', 07:59:34 INFO - 'USER': 'cltbld', 07:59:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 07:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:34 INFO - '_': '/tools/buildbot/bin/python'} 07:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:59:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:59:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:37 INFO - Downloading docopt-0.6.1.tar.gz 07:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:59:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:59:37 INFO - Running setup.py install for blobuploader 07:59:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:59:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:59:37 INFO - Running setup.py install for requests 07:59:37 INFO - Running setup.py install for docopt 07:59:37 INFO - Successfully installed blobuploader requests docopt 07:59:37 INFO - Cleaning up... 07:59:37 INFO - Return code: 0 07:59:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f30307fde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', '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 07:59:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 07:59:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:37 INFO - Using env: {'DISPLAY': ':0', 07:59:37 INFO - 'HOME': '/home/cltbld', 07:59:37 INFO - 'LANG': 'en_US.UTF-8', 07:59:37 INFO - 'LANGUAGE': 'en_US:en', 07:59:37 INFO - 'LOGNAME': 'cltbld', 07:59:37 INFO - 'MAIL': '/var/mail/cltbld', 07:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:37 INFO - 'MOZ_NO_REMOTE': '1', 07:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:37 INFO - 'NO_EM_RESTART': '1', 07:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:37 INFO - 'PWD': '/builds/slave/test', 07:59:37 INFO - 'SHELL': '/bin/bash', 07:59:37 INFO - 'SHLVL': '1', 07:59:37 INFO - 'TERM': 'linux', 07:59:37 INFO - 'TMOUT': '86400', 07:59:37 INFO - 'USER': 'cltbld', 07:59:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 07:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:37 INFO - '_': '/tools/buildbot/bin/python'} 07:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:38 INFO - Running setup.py (path:/tmp/pip-cTf3J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:38 INFO - Running setup.py (path:/tmp/pip-FxUPgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:38 INFO - Running setup.py (path:/tmp/pip-05X2j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:38 INFO - Running setup.py (path:/tmp/pip-jDQ7ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:38 INFO - Running setup.py (path:/tmp/pip-9Sn0zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:38 INFO - Running setup.py (path:/tmp/pip-aa5HTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:38 INFO - Running setup.py (path:/tmp/pip-ABsJiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:38 INFO - Running setup.py (path:/tmp/pip-WM5Lhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:38 INFO - Running setup.py (path:/tmp/pip-lek5eR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:38 INFO - Running setup.py (path:/tmp/pip-eDaWoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:38 INFO - Running setup.py (path:/tmp/pip-OfjIXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:38 INFO - Running setup.py (path:/tmp/pip-18lbLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:39 INFO - Running setup.py (path:/tmp/pip-YhxoU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:39 INFO - Running setup.py (path:/tmp/pip-C9EdNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:39 INFO - Running setup.py (path:/tmp/pip-EhrimT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:39 INFO - Running setup.py (path:/tmp/pip-Ge5dJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:39 INFO - Running setup.py (path:/tmp/pip-pcfhzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:59:39 INFO - Running setup.py install for manifestparser 07:59:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:59:39 INFO - Running setup.py install for mozcrash 07:59:39 INFO - Running setup.py install for mozdebug 07:59:39 INFO - Running setup.py install for mozdevice 07:59:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:59:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:59:39 INFO - Running setup.py install for mozfile 07:59:39 INFO - Running setup.py install for mozhttpd 07:59:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Running setup.py install for mozinfo 07:59:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Running setup.py install for mozInstall 07:59:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Running setup.py install for mozleak 07:59:40 INFO - Running setup.py install for mozlog 07:59:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Running setup.py install for moznetwork 07:59:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Running setup.py install for mozprocess 07:59:40 INFO - Running setup.py install for mozprofile 07:59:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Running setup.py install for mozrunner 07:59:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:59:40 INFO - Running setup.py install for mozscreenshot 07:59:41 INFO - Running setup.py install for moztest 07:59:41 INFO - Running setup.py install for mozversion 07:59:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:59:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:59:41 INFO - Cleaning up... 07:59:41 INFO - Return code: 0 07:59:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:41 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f30307fde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', '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 07:59:41 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 07:59:41 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:41 INFO - Using env: {'DISPLAY': ':0', 07:59:41 INFO - 'HOME': '/home/cltbld', 07:59:41 INFO - 'LANG': 'en_US.UTF-8', 07:59:41 INFO - 'LANGUAGE': 'en_US:en', 07:59:41 INFO - 'LOGNAME': 'cltbld', 07:59:41 INFO - 'MAIL': '/var/mail/cltbld', 07:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:41 INFO - 'MOZ_NO_REMOTE': '1', 07:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:41 INFO - 'NO_EM_RESTART': '1', 07:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:41 INFO - 'PWD': '/builds/slave/test', 07:59:41 INFO - 'SHELL': '/bin/bash', 07:59:41 INFO - 'SHLVL': '1', 07:59:41 INFO - 'TERM': 'linux', 07:59:41 INFO - 'TMOUT': '86400', 07:59:41 INFO - 'USER': 'cltbld', 07:59:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 07:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:41 INFO - '_': '/tools/buildbot/bin/python'} 07:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:41 INFO - Running setup.py (path:/tmp/pip-uzCGdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:41 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)) 07:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:41 INFO - Running setup.py (path:/tmp/pip-VoPQbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:41 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)) 07:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:41 INFO - Running setup.py (path:/tmp/pip-yMml_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:41 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)) 07:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:41 INFO - Running setup.py (path:/tmp/pip-_cNeV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:41 INFO - Running setup.py (path:/tmp/pip-R2gnRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:41 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)) 07:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:41 INFO - Running setup.py (path:/tmp/pip-wNk9LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:41 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)) 07:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:41 INFO - Running setup.py (path:/tmp/pip-KaLTHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 07:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:41 INFO - Running setup.py (path:/tmp/pip-LMXpfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 07:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:42 INFO - Running setup.py (path:/tmp/pip-EjK3s6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:42 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)) 07:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:42 INFO - Running setup.py (path:/tmp/pip-Jn7WWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 07:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:42 INFO - Running setup.py (path:/tmp/pip-5mPCSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:42 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)) 07:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:42 INFO - Running setup.py (path:/tmp/pip-hAVO9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:42 INFO - Running setup.py (path:/tmp/pip-Bo0sBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:42 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)) 07:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:42 INFO - Running setup.py (path:/tmp/pip-2i93Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:42 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)) 07:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:42 INFO - Running setup.py (path:/tmp/pip-b8PLO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:42 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)) 07:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:42 INFO - Running setup.py (path:/tmp/pip-UU5yfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 07:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:42 INFO - Running setup.py (path:/tmp/pip-hIcm49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:42 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)) 07:59:42 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)) 07:59:42 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)) 07:59:42 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)) 07:59:42 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:59:42 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:59:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:59:42 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 07:59:42 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 07:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:42 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 07:59:42 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 07:59:44 INFO - Downloading blessings-1.6.tar.gz 07:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:59:44 INFO - Installing collected packages: blessings 07:59:44 INFO - Running setup.py install for blessings 07:59:44 INFO - Successfully installed blessings 07:59:44 INFO - Cleaning up... 07:59:45 INFO - Return code: 0 07:59:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:45 INFO - Reading from file tmpfile_stdout 07:59:45 INFO - Current package versions: 07:59:45 INFO - argparse == 1.2.1 07:59:45 INFO - blessings == 1.6 07:59:45 INFO - blobuploader == 1.2.4 07:59:45 INFO - docopt == 0.6.1 07:59:45 INFO - functools32 == 3.2.3-2 07:59:45 INFO - jsonschema == 2.5.1 07:59:45 INFO - manifestparser == 1.1 07:59:45 INFO - mozInstall == 1.12 07:59:45 INFO - mozcrash == 1.0 07:59:45 INFO - mozdebug == 0.1 07:59:45 INFO - mozdevice == 0.49 07:59:45 INFO - mozfile == 1.2 07:59:45 INFO - mozhttpd == 0.7 07:59:45 INFO - mozinfo == 0.9 07:59:45 INFO - mozleak == 0.1 07:59:45 INFO - mozlog == 3.4 07:59:45 INFO - moznetwork == 0.27 07:59:45 INFO - mozprocess == 0.23 07:59:45 INFO - mozprofile == 0.28 07:59:45 INFO - mozrunner == 6.13 07:59:45 INFO - mozscreenshot == 0.1 07:59:45 INFO - mozsystemmonitor == 0.3 07:59:45 INFO - moztest == 0.7 07:59:45 INFO - mozversion == 1.4 07:59:45 INFO - psutil == 3.1.1 07:59:45 INFO - requests == 1.2.3 07:59:45 INFO - wsgiref == 0.1.2 07:59:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:45 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f30307fde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', '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 07:59:45 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 07:59:45 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:45 INFO - Using env: {'DISPLAY': ':0', 07:59:45 INFO - 'HOME': '/home/cltbld', 07:59:45 INFO - 'LANG': 'en_US.UTF-8', 07:59:45 INFO - 'LANGUAGE': 'en_US:en', 07:59:45 INFO - 'LOGNAME': 'cltbld', 07:59:45 INFO - 'MAIL': '/var/mail/cltbld', 07:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:45 INFO - 'MOZ_NO_REMOTE': '1', 07:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:45 INFO - 'NO_EM_RESTART': '1', 07:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:45 INFO - 'PWD': '/builds/slave/test', 07:59:45 INFO - 'SHELL': '/bin/bash', 07:59:45 INFO - 'SHLVL': '1', 07:59:45 INFO - 'TERM': 'linux', 07:59:45 INFO - 'TMOUT': '86400', 07:59:45 INFO - 'USER': 'cltbld', 07:59:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 07:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:45 INFO - '_': '/tools/buildbot/bin/python'} 07:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:45 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)) 07:59:45 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)) 07:59:45 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)) 07:59:45 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)) 07:59:45 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)) 07:59:45 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)) 07:59:45 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)) 07:59:45 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)) 07:59:45 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)) 07:59:45 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)) 07:59:45 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)) 07:59:45 INFO - Cleaning up... 07:59:45 INFO - Return code: 0 07:59:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 07:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f30307fde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', '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 07:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:59:45 INFO - Using env: {'DISPLAY': ':0', 07:59:45 INFO - 'HOME': '/home/cltbld', 07:59:45 INFO - 'LANG': 'en_US.UTF-8', 07:59:45 INFO - 'LANGUAGE': 'en_US:en', 07:59:45 INFO - 'LOGNAME': 'cltbld', 07:59:45 INFO - 'MAIL': '/var/mail/cltbld', 07:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:45 INFO - 'MOZ_NO_REMOTE': '1', 07:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:45 INFO - 'NO_EM_RESTART': '1', 07:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:45 INFO - 'PWD': '/builds/slave/test', 07:59:45 INFO - 'SHELL': '/bin/bash', 07:59:45 INFO - 'SHLVL': '1', 07:59:45 INFO - 'TERM': 'linux', 07:59:45 INFO - 'TMOUT': '86400', 07:59:45 INFO - 'USER': 'cltbld', 07:59:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 07:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:45 INFO - '_': '/tools/buildbot/bin/python'} 07:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:59:45 INFO - Cleaning up... 07:59:45 INFO - Return code: 0 07:59:45 INFO - Running post-action listener: _resource_record_post_action 07:59:45 INFO - Running post-action listener: _start_resource_monitoring 07:59:45 INFO - Starting resource monitoring. 07:59:45 INFO - [mozharness: 2016-12-15 15:59:45.742736Z] Finished create-virtualenv step (success) 07:59:45 INFO - [mozharness: 2016-12-15 15:59:45.743197Z] Running install step. 07:59:45 INFO - Running pre-action listener: _resource_record_pre_action 07:59:45 INFO - Running main action method: install 07:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:45 INFO - Reading from file tmpfile_stdout 07:59:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:59:46 INFO - Reading from file tmpfile_stdout 07:59:46 INFO - Output received: 07:59:46 INFO - Usage: mozinstall [options] installer 07:59:46 INFO - Options: 07:59:46 INFO - -h, --help show this help message and exit 07:59:46 INFO - -d DEST, --destination=DEST 07:59:46 INFO - Directory to install application into. [default: 07:59:46 INFO - "/builds/slave/test"] 07:59:46 INFO - --app=APP Application being installed. [default: firefox] 07:59:46 INFO - mkdir: /builds/slave/test/build/application 07:59:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:00:02 INFO - Reading from file tmpfile_stdout 08:00:02 INFO - Output received: 08:00:02 INFO - /builds/slave/test/build/application/firefox/firefox 08:00:02 INFO - Running post-action listener: _resource_record_post_action 08:00:02 INFO - [mozharness: 2016-12-15 16:00:02.999731Z] Finished install step (success) 08:00:03 INFO - [mozharness: 2016-12-15 16:00:02.999971Z] Running run-tests step. 08:00:03 INFO - Running pre-action listener: _resource_record_pre_action 08:00:03 INFO - Running main action method: run_tests 08:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:03 INFO - Python 2.7.3 08:00:03 INFO - Return code: 0 08:00:03 INFO - grabbing minidump binary from tooltool 08:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:00:03 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 0x1fcdf20>, '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 0x1f3ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:03 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 08:00:03 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 08:00:03 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 08:00:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:03 INFO - Return code: 0 08:00:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:00:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:00:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:00:03 INFO - Using env: {'DISPLAY': ':0', 08:00:03 INFO - 'HOME': '/home/cltbld', 08:00:03 INFO - 'LANG': 'en_US.UTF-8', 08:00:03 INFO - 'LANGUAGE': 'en_US:en', 08:00:03 INFO - 'LOGNAME': 'cltbld', 08:00:03 INFO - 'MAIL': '/var/mail/cltbld', 08:00:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:03 INFO - 'MOZ_NO_REMOTE': '1', 08:00:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:03 INFO - 'NO_EM_RESTART': '1', 08:00:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:03 INFO - 'PWD': '/builds/slave/test', 08:00:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:03 INFO - 'SHELL': '/bin/bash', 08:00:03 INFO - 'SHLVL': '1', 08:00:03 INFO - 'TERM': 'linux', 08:00:03 INFO - 'TMOUT': '86400', 08:00:03 INFO - 'USER': 'cltbld', 08:00:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838', 08:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:03 INFO - '_': '/tools/buildbot/bin/python'} 08:00:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:00:03 INFO - mozversion application_buildid: 20161215061212 08:00:03 INFO - mozversion application_changeset: c750a7de1194d71f2d2ef73f6a919d26b9640cae 08:00:03 INFO - mozversion application_display_name: Nightly 08:00:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:03 INFO - mozversion application_name: Firefox 08:00:03 INFO - mozversion application_remotingname: firefox 08:00:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:00:03 INFO - mozversion application_vendor: Mozilla 08:00:03 INFO - mozversion application_version: 53.0a1 08:00:03 INFO - mozversion platform_buildid: 20161215061212 08:00:03 INFO - mozversion platform_changeset: c750a7de1194d71f2d2ef73f6a919d26b9640cae 08:00:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:00:03 INFO - mozversion platform_version: 53.0a1 08:00:03 INFO - using testdate: 1481817603 08:00:03 INFO - actual date: 1481817603 08:00:03 INFO - starting webserver on 'localhost:37771' 08:00:03 INFO - SUITE-START | Running 2 tests 08:00:03 INFO - TEST-START | dromaeo_css 08:00:03 INFO - operating with platform_type : linux_ 08:00:03 INFO - Initialising browser for dromaeo_css test... 08:00:03 INFO - TEST-INFO | started process 3346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5vBYod/profile http://localhost:37771/getInfo.html) 08:00:09 INFO - PROCESS | 3346 | __metrics Screen width/height:1600/1200 08:00:09 INFO - PROCESS | 3346 | colorDepth:24 08:00:09 INFO - PROCESS | 3346 | Browser inner width/height: 1024/697 08:00:09 INFO - PROCESS | 3346 | __metrics 08:00:10 INFO - PROCESS | 3346 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:00:10 INFO - PROCESS | 3346 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:00:10 INFO - PROCESS | 3346 | console.error: PushService: 08:00:10 INFO - PROCESS | 3346 | stateChangeProcessEnqueue: Error transitioning state 08:00:10 INFO - PROCESS | 3346 | UnknownError 08:00:11 INFO - TEST-INFO | 3346: exit 0 08:00:11 INFO - Browser initialized. 08:00:11 INFO - Running cycle 1/1 for dromaeo_css test... 08:00:11 INFO - TEST-INFO | started process 3434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5vBYod/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:23 INFO - PROCESS | 3434 | RSS: Main: 172855296 08:00:23 INFO - PROCESS | 3434 | 08:01:14 INFO - PROCESS | 3434 | 1481817674967 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:03:24 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:37771/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37771/tests/dromaeo/cssquery-ext.html) 08:03:27 INFO - PROCESS | 3434 | RSS: Main: 415076352 08:03:27 INFO - PROCESS | 3434 | 08:06:29 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:37771/tests/dromaeo/cssquery-ext.html (next: http://localhost:37771/tests/dromaeo/cssquery-jquery.html) 08:06:30 INFO - PROCESS | 3434 | RSS: Main: 285294592 08:06:30 INFO - PROCESS | 3434 | 08:09:32 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:37771/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37771/tests/dromaeo/cssquery-mootools.html) 08:09:33 INFO - PROCESS | 3434 | RSS: Main: 223444992 08:09:33 INFO - PROCESS | 3434 | 08:12:35 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:37771/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37771/tests/dromaeo/cssquery-prototype.html) 08:12:35 INFO - PROCESS | 3434 | RSS: Main: 285286400 08:12:35 INFO - PROCESS | 3434 | 08:15:38 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:37771/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37771/tests/dromaeo/cssquery-yui.html) 08:15:39 INFO - PROCESS | 3434 | RSS: Main: 220991488 08:15:39 INFO - PROCESS | 3434 | 08:18:42 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:37771/tests/dromaeo/cssquery-yui.html (next: http://localhost:37771/tests/dromaeo/cssquery-dojo.html) 08:18:42 INFO - PROCESS | 3434 | RSS: Main: 314744832 08:18:42 INFO - PROCESS | 3434 | 08:18:42 INFO - PROCESS | 3434 | __start_tp_report 08:18:42 INFO - PROCESS | 3434 | _x_x_mozilla_page_load 08:18:42 INFO - PROCESS | 3434 | _x_x_mozilla_page_load_details 08:18:42 INFO - PROCESS | 3434 | |i|pagename|runs| 08:18:42 INFO - PROCESS | 3434 | |0;dojo.html;3006.954895676565;3025.213444504428;3058.235441139715;3061.494853349196;3068.0642404066753;5161.9741901290445;5195.896082078366;5196.9480305196985;5200.271961925324;5263.447338029509;5147.1764517677175;5178.870528236796;5181.378234611842;5244.921326180101;5276.445973172828;4775.4985726498735;4779.259214821708;4816.723568254415;4818.807247710088;4837.4195096588455;4814.9759251203695;4827.589654879322;4864.7324397158145;4898.828541001048;4909.386326709161;4854.36893203883;4854.58736007438;4873.195922672772;4893.14369985253;4908.7300198489065;4745.59662428694;4749.026449577863;4768.070226305872;4840.15297322967;4877.365942427497;4726.007538416937;4739;4759.048190361941;4786.377770889762;4836.371271734687;5213.869653258661;5221.843344699665;5232.581393488512;5254.527092561688;5308.893822123575;5481.424450432727;5618.606697531174;5621.072523033695;5623.662580245198;5626.099824028136;5530.391656917735;5542.002439560877;5543.972280138614;5558.194061861048;5650.971745141248;5233.215017747369;5233.5551478124025;5234.110201265794;5235.816746413857;5238.659487133325;5693.857653558612;5694.08894576874;5704;5710.086386178192;5750.654960702372;5421.349438067378;5437.048516509595;5473.808416705396;5476.58925580583;5480;5543.36251331094;5553;5576;5579.358373786985;5657.858553536113;5513.972430137824;5566.972165139229;5567.192757050205;5576.191452239403;5584.246126772834;5478.91781623276;5494.642848214853;5495.53287970527;5556.472135147154;5605.32736071674;4350.042990542076;4402.163588918095;4404.757738324423;4409.096135292258;4412.558744125626;3921.8235179416993;3924.6271604198128;3930.665893399036;3964.444977703124;3975.7614543127506;5428.864278393072;5430.511253987082;5432.51107400328;5436.755346009439;5481.177823326453;5480.534154596904;5514.28314319144;5545.085060964976;5581.134924086773;5688.089905615082;5295;5345.278387417727;5385.27298814655;5385.407605163429;5385.649932754359;4881.072596206709;4881.682690625098;4885.926711099336;4909.361782968263;4924.162892308244;5735.655860648374;5795.043817770021;5805.970970145122;5808.041673123972;5808.970955145197;5487.122060470306;5503.3395992481155;5505.064139096443;5505.201745746925;5556.944180605672;5755.769769209185;5766.4233576642;5767.942320576908;5796.94203057964;5813.128030795415;5562.5549956002615;5569.08110161835;5573.5819813513335;5578.693171875586;5579.637323573955;5464.2076898848645;5495.340559132929;5607.495325420732;5610.579206559442;5653.067243904709;5428;5460.7542660579575;5469.15228139639;5469.699166545719;5472.835814925558;5440.7551660174595;5445.727713614224;5449.564034877121;5466.234727138283;5469.288992430958;5368.436314186954;5407.810726624549;5410.215518749838;5412.269343638558;5415;5505.284313039279;5524.640898341595;5529.751161197675;5534.584906131976;5537.169424586345;5455.372632147354;5457.945420545744;5459.12653975362;5475.863103422446;5478.506934375766 08:18:42 INFO - PROCESS | 3434 | |1;ext.html;555.588864240462;576.3688760806917;589.4518098168704;590.9911351329731;597.2027343496432;31356.216094597647;38461.615383846154;40580.391294130575;40727.185456290856;43828.3425748614;42282;42573.36139957903;42685.14629707404;42702.35946460798;42705;7804.843903121934;8635.438696484724;8831.337649676268;8834.337424693142;8834.425762325429;7833.21667833215;8046.517208967452;8051.637676304551;10054.447005414699;10323.225758068138;10413.21900857435;10468.16254699626;10473.581056757721;10478.37129772216;10482.633107841228;10254.333468324572;10313.07182353588;10315.948420257926;10322.793544129076;10328.690139295833;10221.744456388575;10243.487825608765;10284.691459256233;10290.485475726258;10291.588336466531;40588.39117413211;40673.79663101665;40889;40904.79547602273;40952.180956380704;2978.3596526746637;3254.886078987248;3318.4026875162463;3332.216929021678;3575.7496975211748;25836.74163258362;27009.729902701114;27356.863215683992;27481.31296717578;28410.71589284122;4134.896627584304;4149.751014939114;4164.371597715347;4195.475565554306;4253.957460425387;308356;309194;309973.9540371246;310862;310870;50103;50187.74906125446;50199.498005020214;50220.9823214142;50293.74853125711;51644.74177629163;51734.482655172964;51753.96492070137;52142.217866732026;52156.739216304435;14422.639434014234;14910.701785964437;14916.776248356284;14918;14931.178785166703;9440.339176257734;11610.187286889837;11773.058155347551;11773.52905883755;11775.587854425054;14586.562403127924;16426.917865410596;16570.420035298946;16664.83335166657;17204.91397543004;6422.229332480132;6431.356864313531;6492.837679058061;6547.541672082908;6599.47204223661;860.8493513635088;980.8038392321564;983.3902980152351;1069.8395240713799;1096.8628921384827;30755.538666920012;30772.846135769178;30879.536806947915;31030.68969310278;31427.84286078555;1025.0518270599666;1078.229066217658;1090.3893819461127;1133.982990255147;1159.652104368686;15755.212239387985;16217.675646487005;16298.67402651964;16328.34686612546;16654.50036498907;538518;541351;543338;543605;543993;54799.72600137054;55226.3057640097;55232.44767552354;55234.447655522934;55314.446855531736;1283.3390803736083;1314.3822403470544;1323.0275747325709;1323.1664051647401;1326.6683329167709;27508.312292192855;29228;29904.401911962075;29928.25179370446;30580.541291881083;48698.26952595643;49250.75374623104;49296;49360.75319623522;49374.25938610995;408747;411467;417631;420049;420711;24450.51098978046;25030.62454063154;26252;27031.72968270292;27609.171724848286;41781.58218417777;43578.34632480579;43831.34252986144;44940.55059449364;45341.77329113333;37162.628373717;38057.4291385635;38564.6143538561;38972;40024.7998760016;37713.62286377101;37904.620953791215;37933;38200.808995954845;38479.61520384761;35320;35646.82176589101;35836.28327433489;38219.61780382161;38374.23251534898;29384.706152939052;32693.836530817192;32742;32754.344913102083;32867;24099.397515062265;24741.381465463506;24829.751702483467;25196.370090747143;25223.495530088927 08:18:42 INFO - PROCESS | 3434 | |2;jquery.html;357.5316335600362;370.3740678253751;375.5737238234603;385.5604610743752;398.3506883779441;14036.157830530163;17189.656206875854;18062.729059064124;19097.809021909776;19267.22931082755;17507.47477575675;18027.36904208353;18109.4567162985;18253.634927301446;18606.16272267748;4993.325901003354;5241.371035475749;5263.815766448175;5269.604779641523;5272.367315922094;3776.1126135358304;4288.7212331198525;5147.459516750743;5233;5237.3715154181555;4335.176316499871;6345.619262844221;6372.808815735535;6443.9355606443805;6450.4839612830865;5743.913841292384;5749.108888122348;6221.160143380631;6440.871182576346;6443.033544968245;5593.8321850344555;5599.300087489064;5604.859878503029;5606.971965140189;5607.130894711327;13449.394777235048;19818.60362792736;21451.892740536354;22051.889740551356;22205.77794222053;2083.2500299892026;2120.703101565782;2192.572448372568;2267.7278726552754;2375.5011447596025;8071.434999550034;9338.813223735488;9339.392939458981;10259.230557708128;10308.32995855267;1850.4078694817663;1883.1808163448807;1896.6680830854546;1959.1575622482326;1959.2652755216793;68438.04991201434;76578.61710691467;77111.22888771097;78454;79498.99999999942;10431.94784026075;10556.577736890593;10681.83977240342;10814.675559733221;10898.237123401444;14981.951263411675;15009.774853377208;15018.624534386508;15021.849781502264;15044.924775376272;7374.446916481285;7722.6910923563555;7761.534307941542;7905.644246008944;7929.484583502054;7243.420526357879;7265.346118849223;7271.854562908712;7536.434767392468;7570.886436703454;4520.932186017212;4578.702384345007;4604.953950460519;4611.608013318838;4627.519193857933;1787.2136260045538;1833.0839848700955;1847.353426300784;1930.6331796958532;1946.8442524598;800.7197480881762;876.8071024374627;909.7952960583948;925.8703781470599;950.5247376311844;16952.253369056685;18708.719369209473;18903.338383156522;19086.52283692891;19278.22887084529;874.9781255468537;890.2388457868559;936.5364144748393;940.1303793990668;952.4333021851987;9802.313838031268;10471;10584.707646176912;10597.682069537772;10623.20325975555;357130;394600;396882;397057;398901;62075.6896215516;76768.61615691886;82411;84218;89419.55290223638;947.7677968897664;976.9853452198223;985.6353149334649;998.5157198758596;1000.2198285337448;16069.910911581419;16211.432599858948;16497.010179389275;16682.416115435903;16869.91565042167;39409.80295098506;39544.2091158181;40423.59576404198;40547.1890562193;40970.79514602408;55035;55351.72324138354;56269.155962659774;56368;56391.15413268886;7766.650500727368;8076.232757887991;8172.468789528662;8235.588220589067;8423.368247381593;8951.552422378725;9190.770230744285;11578.421078946187;12212.206206596542;12228.755424891275;6866.416354609714;10090.747731306483;10337.9483102584;10500.632477863239;10668;10537.209709271681;10844.40355780408;10915;10935.83596246073;11676.357800321064;10383.636572719919;10546.26176167661;10552.472376380996;10912.727181820517;11066.723331916444;7752.728654497066;7859.764207073797;7872.724454644289;7880.487768295043;8115.675372985014;9844.60621575129;10081.747956301151;10118.443485608363;10169.694909152737;10301.793964120525 08:18:42 INFO - PROCESS | 3434 | |3;mootools.html;1383.9584812455628;1418.5957002254354;1505.5709122899975;1678.3118921242294;1700.4643537285763;7192.136943566767;7429.8885516717155;7738.419618528612;8195.180481951802;8198.836023279531;7741.341985931189;7990.560519171443;7991.9600401997905;8176.182381761821;8184.959075204616;2226.8886555672234;2259.288324177887;2260.8530445520987;2263.7849404306567;2266.8526545774553;1967.2819420911335;2031.786662400449;2198.428408613764;2230.453538882976;2236.7539570647214;2127;2188.89055547222;2198.5383069555332;2198.9560208795815;2209.94475138122;2197.088208393515;2204.7244094488187;2209.679596458521;2212.6127927612765;2224.410531209231;2198.7251593550805;2200.7579166291694;2221.711177546925;2230.6988556544984;2233.932982010542;7930.563818989954;8111.918880811176;8131.390145739093;8134;8136.552489613069;4777.355057067321;5004.374453193351;5004.449510553836;5005.474425185376;5007.4241462231585;3191.457452233126;3237.2877966847254;3311.6688331166933;3325.1853295942406;3344.5317655528247;1050.2490719135778;1050.7373156710823;1106.0653747583278;1114.4650567727456;1134.4384529657873;11000.339979601169;11002.394868282241;11038.337699738042;11042.171837112168;11046.613368532062;4118.19695159447;4275.209086319041;4344.869653910388;4381.277089280296;4407.713498622579;9315.627374905063;9455.243580513543;9480.478573678376;9483.810323793623;9494.525273736286;4835.903281934342;4874.975625121851;4911;4915.778789954461;5024.0956627807345;4308.224519586504;4499.122671079108;4502.662300327489;4504.572065653758;4589.33454649074;3578.6958108560543;3697.5008373869723;3704.666320124753;3737.551493820759;3797.4493698414126;1075.575147816608;1100.2463312630873;1186.5609724401854;1200.6398080575793;1220.5117952818944;845.2730651639584;869.9391042626955;896.5606852642159;926.5598840550684;935.1209862729013;5306.6550674206055;5391.029614669319;5637.548996080303;5668.376478587352;5796.304443466811;930.2883294279882;938.3994243684048;959.947202903833;961.5000199896015;988.3790583443159;3893.3575959966856;3922.7057970652313;3950.565437801897;3967.0677390813134;3984.163325701635;9606.759831004281;10042.799144017079;10051.597936082475;10052.64815731446;10063.39619622825;9897.059779320953;9967;9968.302218844756;9974.501274936369;9994.150497207673;7319.34125928669;7463.776086717407;7520;7629.618519074135;7633.69465221385;5472.261244731911;5518.199861020049;5559.805406810742;5696.174054761954;5705.172749951151;8838.513881736566;8882.111788821067;8908.955455222682;8917.464952102895;8935.463872167691;8531.616077276662;9154.954225229098;9194.31042671789;9211.124943130391;9270.582823772811;7279.27207279289;7531.3598344141365;7626.923730762622;7671.961640191764;7677.117131529945;7414.258574142543;7640.617969101411;7672.769816905502;7713.7685869424;7724.729634462767;5706.543476521952;6632.668366581748;6898.206706228647;7060.188078371053;7100.964495177491;6797.320267973163;6804.9319506804295;6879.380855723009;7079.327463890922;7192.856142877218;6328.240611126695;6359.650219237801;6366.64983425916;6453.032045193258;6483.805485835433;4508.571685689854;4540.114677637829;4696.647751418725;4842.4189097308545;4855.878603034952;4750.548697873696;4793.089313030513;4904.068227036852;4914.533119353656;4930.605551555938 08:18:42 INFO - PROCESS | 3434 | |4;prototype.html;336.60617078018714;348.7489007914304;355.1281603663009;358.6270278909933;363.6690611543495;5068.898622027557;5076.137101289847;5095.872603184922;5102.872428189297;5155.71643559604;5078;5109.923351149736;5110.56904066861;5110.718910459923;5131.871703207422;3919.3533067044045;4024.29574824406;4049.574794646549;4064.870050061451;4064.9390259146135;3980.4825372701507;4018.899527511821;4039.919201615966;4045.1909618076356;4073.551909289976;4023.6781057515327;4029.1941611677635;4044.5348784889675;4048.4736984192014;4049.777262250575;4025.4364388985564;4026.5973402659793;4055.1281474482835;4056.837726490937;4077.674755704378;3420.8973730788116;3486.2853115111343;3487.4768784682246;3527.982360088183;3704.7036237100965;4995.625328100407;4996.325496058058;5000.849974500771;5005.174146265898;5033.370828646419;4670.921439959219;4679.60223381013;4681.812727490897;4690.484046754854;4698.953010469886;5160.974195129038;5310.415854256029;5342.358916929993;5342.786288548454;5351.2240725095035;3970.4242884781834;4005;4010.859619913289;4023.8591649292134;4029.7582145071096;5506.587005974568;5542.224088627595;5550.4449555044575;5567.610267281292;5589.441055894459;4042.2319759245647;4096.836126554964;4099.262132816062;4120.670346372283;4153.833846646161;4148.896277593084;4161.313383291784;4162.396452514429;4179.2477354076555;4183.686223533186;4653.092646933816;4667.136579732693;4676.275177347517;4677.976610116928;4686.507916668769;5256.553192978563;5356.758945847446;5414.620976531605;5443.972780136074;5452.100403433468;1398.6363545478248;1410.8659677330638;1413.2086031822212;1419.6158745223531;1425.7861320801755;953.4041224234853;1005.0903931941605;1017.2523195451338;1018.7809620931536;1019.5513973851481;5070.29015937769;5090.898182036339;5109.463506331856;5127.820526281562;5130.769115389817;5302.973485132549;5338;5394.649347792381;5415.323084614423;5542.972285138549;5223.921641175385;5225.190095535198;5251.238570407269;5267.341582302212;5268.81559145428;2714.1586108306487;2823.647044119485;2842.928926776847;2844.985775071111;2848.2167403964077;5442.863928401743;5472.5348345391085;5498.532624726943;5545.861353466195;5552.944470555323;5393.952416884447;5411.377691565442;5426.751847075195;5458.335207761592;5464.617476776588;5324.8136315228785;5479.643823151482;5490.835274941678;5493.945060549343;5519.227308176778;5306.97346513265;5322.228276899906;5326.813561525328;5331.973340133274;5350.8127215547265;5283.947160528499;5341.985022845647;5356.089464791073;5365.248865158959;5382.703951282717;5240.764165612481;5441.83674489766;5478.91781623268;5497.8075767347955;5558.722063896708;4079.6124368184974;4080.163566468926;4081.6734661227624;4098.7950602470355;4101.8974525637095;5367;5403.7838486460105;5404.784153428704;5423.637344846221;5427.457254274699;5122.667026643257;5218.921716174336;5222.582193424593;5252.606054546;5285.497877701766;5182.714950677598;5195.558377537952;5199.92200116991;5201.219817027476;5241.528262456397;5038.722870242172;5166.328377310925;5202.791888324425;5211.166213405989;5218.373795144607;5177.896442071213;5181.611379146504;5208.348956380452;5231.476852314738;5290.523852853262;5019.799208031784;5114.15616423286;5123.897522049613;5210.869728256824;5288.762005709829 08:18:42 INFO - PROCESS | 3434 | |5;yui.html;633.1262857256991;670.1756839087925;690.7893092606756;695.9721611135554;742.9739959101429;13748.106373085742;14883.330250138742;14889.329980150893;15074.698506029887;15075.246237688112;13833.861661383384;14075.859241407583;14082.71834563308;14082.859171408283;14090;673.4679603113534;693.8612277544486;793.9523628582289;809.0655293136437;810.6878851642131;780.7501599488166;803.1165717710501;813.975580732576;815.7063457155419;816.9183081691813;850.3324889961382;851.642310229705;852.2329903087209;854.5214679779313;855.2260204514893;697.8464737757686;717.0928775099503;848.5205858689851;849.0066622052183;849.027863096757;532.1963834609728;532.4861508644177;596.7314708381246;612.9908051379233;619.4734475695668;13798.862011379859;13839.238841863693;13840.792388114187;13844.30778461083;13850.16898986064;11094.167937404727;11198.552057917674;11282.605108821233;11337.773244535063;11793.997510211642;12111.62882918603;12137.297409922734;12220.816687749691;12222;12301.446434910451;4126.979365103155;4165.354370072643;4175.62419382254;4200.409626723926;4313.654907607384;71976.280237198;72742.63628681823;74809.62595187043;75136.87294690638;75865;9308.255339572817;9530.285228607881;9548.90451095494;9582.472963986907;10278.33190842593;17310.65378692419;17312.394066207624;17313.134343283036;17336.3065477382;17397.217125229396;7723.65243564041;7799;7829.843403131906;7898.01274840645;7921.603919803987;4241.703080784378;4244.3209086546;4351.8694439166875;4371.409859668904;4417.293233082692;3170.9682903170674;3241.7406607471344;3242.0760083376595;3245.3509298140466;3257.2671148991762;561.9775208991676;566.9461401166883;567.4354017752363;589.9085641725453;595.9642421454727;535.0476152448648;574.9540036797047;575.3153747041008;590.3742033444563;603.9698015099316;7463.216362281991;8026.38320309187;8411.537365444838;8847.513386763661;8893.866592000995;599.4395240450193;602.3284038297267;611.6910959965278;621.6177051113533;654.3685343643407;3952.150287688161;4086.7752273625238;4184.14225083857;4227.640650544677;4235.322348424237;80617.59691201507;82893;83088.16911830925;83733;85106.14893850982;73728;74384;75089.62455187688;75165;75417;63995.360046400805;65152.67423662851;66301.66849165723;67315.32684673091;68091.65954170296;8005.679772809255;8319.126491718282;8359.205875441823;8391.202835730595;8521.190486903733;45160;45811.54188458073;46040.53959460497;46165.53834461747;47863.76068119637;58598;61670.38329616647;61901.690491547255;61974.38025619867;63889.36110638834;10304.330218535772;10359.585616575554;10519.947400263256;10869.67390978272;10892;11544.054662443354;11675.35785531804;11682.649520514398;11768.58809941648;11877.58428455;11164.218504704593;11243.887302966365;11362.375069370933;11464.82802757976;11757.118216133653;8641.8703719443;11798.764024719287;12045.33750643723;12064.698382540506;12841.550545730855;11995.460204290654;12878.227306361649;12920.35398230066;13152.342382881008;13204.735905282032;9705.223582113273;9727.756806079622;9813.85279220798;9963.651272205438;10461.424621645883;10415.323004004715;10834.404107774148;10956.86737075833;11005.669829905115;11039.448027598748 08:18:42 INFO - PROCESS | 3434 | __end_tp_report 08:18:42 INFO - PROCESS | 3434 | __start_cc_report 08:18:42 INFO - PROCESS | 3434 | _x_x_mozilla_cycle_collect,2497 08:18:42 INFO - PROCESS | 3434 | __end_cc_report 08:18:42 INFO - PROCESS | 3434 | __startTimestamp1481818722627__endTimestamp 08:18:42 INFO - PROCESS | 3434 | 08:18:42 INFO - PROCESS | 3434 | ------- Summary: start ------- 08:18:42 INFO - PROCESS | 3434 | Number of tests: 6 08:18:42 INFO - PROCESS | 3434 | 08:18:42 INFO - PROCESS | 3434 | [#0] dojo.html Cycles:165 Average:5217.33 Median:5440.76 stddev:561.47 (10.3%) stddev-sans-first:535.75 08:18:42 INFO - PROCESS | 3434 | Values: 3007.0 3025.2 3058.2 3061.5 3068.1 5162.0 5195.9 5196.9 5200.3 5263.4 5147.2 5178.9 5181.4 5244.9 5276.4 4775.5 4779.3 4816.7 4818.8 4837.4 4815.0 4827.6 4864.7 4898.8 4909.4 4854.4 4854.6 4873.2 4893.1 4908.7 4745.6 4749.0 4768.1 4840.2 4877.4 4726.0 4739.0 4759.0 4786.4 4836.4 5213.9 5221.8 5232.6 5254.5 5308.9 5481.4 5618.6 5621.1 5623.7 5626.1 5530.4 5542.0 5544.0 5558.2 5651.0 5233.2 5233.6 5234.1 5235.8 5238.7 5693.9 5694.1 5704.0 5710.1 5750.7 5421.3 5437.0 5473.8 5476.6 5480.0 5543.4 5553.0 5576.0 5579.4 5657.9 5514.0 5567.0 5567.2 5576.2 5584.2 5478.9 5494.6 5495.5 5556.5 5605.3 4350.0 4402.2 4404.8 4409.1 4412.6 3921.8 3924.6 3930.7 3964.4 3975.8 5428.9 5430.5 5432.5 5436.8 5481.2 5480.5 5514.3 5545.1 5581.1 5688.1 5295.0 5345.3 5385.3 5385.4 5385.6 4881.1 4881.7 4885.9 4909.4 4924.2 5735.7 5795.0 5806.0 5808.0 5809.0 5487.1 5503.3 5505.1 5505.2 5556.9 5755.8 5766.4 5767.9 5796.9 5813.1 5562.6 5569.1 5573.6 5578.7 5579.6 5464.2 5495.3 5607.5 5610.6 5653.1 5428.0 5460.8 5469.2 5469.7 5472.8 5440.8 5445.7 5449.6 5466.2 5469.3 5368.4 5407.8 5410.2 5412.3 5415.0 5505.3 5524.6 5529.8 5534.6 5537.2 5455.4 5457.9 5459.1 5475.9 5478.5 08:18:42 INFO - PROCESS | 3434 | 08:18:42 INFO - PROCESS | 3434 | [#1] ext.html Cycles:180 Average:56928.47 Median:19706.02 stddev:115109.22 (584.1%) stddev-sans-first:115354.32 08:18:42 INFO - PROCESS | 3434 | Values: 555.6 576.4 589.5 591.0 597.2 31356.2 38461.6 40580.4 40727.2 43828.3 42282.0 42573.4 42685.1 42702.4 42705.0 7804.8 8635.4 8831.3 8834.3 8834.4 7833.2 8046.5 8051.6 10054.4 10323.2 10413.2 10468.2 10473.6 10478.4 10482.6 10254.3 10313.1 10315.9 10322.8 10328.7 10221.7 10243.5 10284.7 10290.5 10291.6 40588.4 40673.8 40889.0 40904.8 40952.2 2978.4 3254.9 3318.4 3332.2 3575.7 25836.7 27009.7 27356.9 27481.3 28410.7 4134.9 4149.8 4164.4 4195.5 4254.0 308356.0 309194.0 309974.0 310862.0 310870.0 50103.0 50187.7 50199.5 50221.0 50293.7 51644.7 51734.5 51754.0 52142.2 52156.7 14422.6 14910.7 14916.8 14918.0 14931.2 9440.3 11610.2 11773.1 11773.5 11775.6 14586.6 16426.9 16570.4 16664.8 17204.9 6422.2 6431.4 6492.8 6547.5 6599.5 860.8 980.8 983.4 1069.8 1096.9 30755.5 30772.8 30879.5 31030.7 31427.8 1025.1 1078.2 1090.4 1134.0 1159.7 15755.2 16217.7 16298.7 16328.3 16654.5 538518.0 541351.0 543338.0 543605.0 543993.0 54799.7 55226.3 55232.4 55234.4 55314.4 1283.3 1314.4 1323.0 1323.2 1326.7 27508.3 29228.0 29904.4 29928.3 30580.5 48698.3 49250.8 49296.0 49360.8 49374.3 408747.0 411467.0 417631.0 420049.0 420711.0 24450.5 25030.6 26252.0 27031.7 27609.2 41781.6 43578.3 43831.3 44940.6 45341.8 37162.6 38057.4 38564.6 38972.0 40024.8 37713.6 37904.6 37933.0 38200.8 38479.6 35320.0 35646.8 35836.3 38219.6 38374.2 29384.7 32693.8 32742.0 32754.3 32867.0 24099.4 24741.4 24829.8 25196.4 25223.5 08:18:42 INFO - PROCESS | 3434 | 08:18:42 INFO - PROCESS | 3434 | [#2] jquery.html Cycles:180 Average:25024.27 Median:219662.30 stddev:64514.93 (29.4%) stddev-sans-first:64669.33 08:18:42 INFO - PROCESS | 3434 | Values: 357.5 370.4 375.6 385.6 398.4 14036.2 17189.7 18062.7 19097.8 19267.2 17507.5 18027.4 18109.5 18253.6 18606.2 4993.3 5241.4 5263.8 5269.6 5272.4 3776.1 4288.7 5147.5 5233.0 5237.4 4335.2 6345.6 6372.8 6443.9 6450.5 5743.9 5749.1 6221.2 6440.9 6443.0 5593.8 5599.3 5604.9 5607.0 5607.1 13449.4 19818.6 21451.9 22051.9 22205.8 2083.3 2120.7 2192.6 2267.7 2375.5 8071.4 9338.8 9339.4 10259.2 10308.3 1850.4 1883.2 1896.7 1959.2 1959.3 68438.0 76578.6 77111.2 78454.0 79499.0 10431.9 10556.6 10681.8 10814.7 10898.2 14982.0 15009.8 15018.6 15021.8 15044.9 7374.4 7722.7 7761.5 7905.6 7929.5 7243.4 7265.3 7271.9 7536.4 7570.9 4520.9 4578.7 4605.0 4611.6 4627.5 1787.2 1833.1 1847.4 1930.6 1946.8 800.7 876.8 909.8 925.9 950.5 16952.3 18708.7 18903.3 19086.5 19278.2 875.0 890.2 936.5 940.1 952.4 9802.3 10471.0 10584.7 10597.7 10623.2 357130.0 394600.0 396882.0 397057.0 398901.0 62075.7 76768.6 82411.0 84218.0 89419.6 947.8 977.0 985.6 998.5 1000.2 16069.9 16211.4 16497.0 16682.4 16869.9 39409.8 39544.2 40423.6 40547.2 40970.8 55035.0 55351.7 56269.2 56368.0 56391.2 7766.7 8076.2 8172.5 8235.6 8423.4 8951.6 9190.8 11578.4 12212.2 12228.8 6866.4 10090.7 10337.9 10500.6 10668.0 10537.2 10844.4 10915.0 10935.8 11676.4 10383.6 10546.3 10552.5 10912.7 11066.7 7752.7 7859.8 7872.7 7880.5 8115.7 9844.6 10081.7 10118.4 10169.7 10301.8 08:18:42 INFO - PROCESS | 3434 | 08:18:42 INFO - PROCESS | 3434 | [#3] mootools.html Cycles:180 Average:5329.84 Median:5004.96 stddev:2944.06 (58.8%) stddev-sans-first:2937.38 08:18:42 INFO - PROCESS | 3434 | Values: 1384.0 1418.6 1505.6 1678.3 1700.5 7192.1 7429.9 7738.4 8195.2 8198.8 7741.3 7990.6 7992.0 8176.2 8185.0 2226.9 2259.3 2260.9 2263.8 2266.9 1967.3 2031.8 2198.4 2230.5 2236.8 2127.0 2188.9 2198.5 2199.0 2209.9 2197.1 2204.7 2209.7 2212.6 2224.4 2198.7 2200.8 2221.7 2230.7 2233.9 7930.6 8111.9 8131.4 8134.0 8136.6 4777.4 5004.4 5004.4 5005.5 5007.4 3191.5 3237.3 3311.7 3325.2 3344.5 1050.2 1050.7 1106.1 1114.5 1134.4 11000.3 11002.4 11038.3 11042.2 11046.6 4118.2 4275.2 4344.9 4381.3 4407.7 9315.6 9455.2 9480.5 9483.8 9494.5 4835.9 4875.0 4911.0 4915.8 5024.1 4308.2 4499.1 4502.7 4504.6 4589.3 3578.7 3697.5 3704.7 3737.6 3797.4 1075.6 1100.2 1186.6 1200.6 1220.5 845.3 869.9 896.6 926.6 935.1 5306.7 5391.0 5637.5 5668.4 5796.3 930.3 938.4 959.9 961.5 988.4 3893.4 3922.7 3950.6 3967.1 3984.2 9606.8 10042.8 10051.6 10052.6 10063.4 9897.1 9967.0 9968.3 9974.5 9994.2 7319.3 7463.8 7520.0 7629.6 7633.7 5472.3 5518.2 5559.8 5696.2 5705.2 8838.5 8882.1 8909.0 8917.5 8935.5 8531.6 9155.0 9194.3 9211.1 9270.6 7279.3 7531.4 7626.9 7672.0 7677.1 7414.3 7640.6 7672.8 7713.8 7724.7 5706.5 6632.7 6898.2 7060.2 7101.0 6797.3 6804.9 6879.4 7079.3 7192.9 6328.2 6359.7 6366.6 6453.0 6483.8 4508.6 4540.1 4696.6 4842.4 4855.9 4750.5 4793.1 4904.1 4914.5 4930.6 08:18:42 INFO - PROCESS | 3434 | 08:18:42 INFO - PROCESS | 3434 | [#4] prototype.html Cycles:180 Average:4501.64 Median:5110.64 stddev:1272.71 (24.9%) stddev-sans-first:1237.29 08:18:42 INFO - PROCESS | 3434 | Values: 336.6 348.7 355.1 358.6 363.7 5068.9 5076.1 5095.9 5102.9 5155.7 5078.0 5109.9 5110.6 5110.7 5131.9 3919.4 4024.3 4049.6 4064.9 4064.9 3980.5 4018.9 4039.9 4045.2 4073.6 4023.7 4029.2 4044.5 4048.5 4049.8 4025.4 4026.6 4055.1 4056.8 4077.7 3420.9 3486.3 3487.5 3528.0 3704.7 4995.6 4996.3 5000.8 5005.2 5033.4 4670.9 4679.6 4681.8 4690.5 4699.0 5161.0 5310.4 5342.4 5342.8 5351.2 3970.4 4005.0 4010.9 4023.9 4029.8 5506.6 5542.2 5550.4 5567.6 5589.4 4042.2 4096.8 4099.3 4120.7 4153.8 4148.9 4161.3 4162.4 4179.2 4183.7 4653.1 4667.1 4676.3 4678.0 4686.5 5256.6 5356.8 5414.6 5444.0 5452.1 1398.6 1410.9 1413.2 1419.6 1425.8 953.4 1005.1 1017.3 1018.8 1019.6 5070.3 5090.9 5109.5 5127.8 5130.8 5303.0 5338.0 5394.6 5415.3 5543.0 5223.9 5225.2 5251.2 5267.3 5268.8 2714.2 2823.6 2842.9 2845.0 2848.2 5442.9 5472.5 5498.5 5545.9 5552.9 5394.0 5411.4 5426.8 5458.3 5464.6 5324.8 5479.6 5490.8 5493.9 5519.2 5307.0 5322.2 5326.8 5332.0 5350.8 5283.9 5342.0 5356.1 5365.2 5382.7 5240.8 5441.8 5478.9 5497.8 5558.7 4079.6 4080.2 4081.7 4098.8 4101.9 5367.0 5403.8 5404.8 5423.6 5427.5 5122.7 5218.9 5222.6 5252.6 5285.5 5182.7 5195.6 5199.9 5201.2 5241.5 5038.7 5166.3 5202.8 5211.2 5218.4 5177.9 5181.6 5208.3 5231.5 5290.5 5019.8 5114.2 5123.9 5210.9 5288.8 08:18:42 INFO - PROCESS | 3434 | 08:18:42 INFO - PROCESS | 3434 | [#5] yui.html Cycles:180 Average:17346.35 Median:567.19 stddev:23583.57 (4158.0%) stddev-sans-first:23616.33 08:18:42 INFO - PROCESS | 3434 | Values: 633.1 670.2 690.8 696.0 743.0 13748.1 14883.3 14889.3 15074.7 15075.2 13833.9 14075.9 14082.7 14082.9 14090.0 673.5 693.9 794.0 809.1 810.7 780.8 803.1 814.0 815.7 816.9 850.3 851.6 852.2 854.5 855.2 697.8 717.1 848.5 849.0 849.0 532.2 532.5 596.7 613.0 619.5 13798.9 13839.2 13840.8 13844.3 13850.2 11094.2 11198.6 11282.6 11337.8 11794.0 12111.6 12137.3 12220.8 12222.0 12301.4 4127.0 4165.4 4175.6 4200.4 4313.7 71976.3 72742.6 74809.6 75136.9 75865.0 9308.3 9530.3 9548.9 9582.5 10278.3 17310.7 17312.4 17313.1 17336.3 17397.2 7723.7 7799.0 7829.8 7898.0 7921.6 4241.7 4244.3 4351.9 4371.4 4417.3 3171.0 3241.7 3242.1 3245.4 3257.3 562.0 566.9 567.4 589.9 596.0 535.0 575.0 575.3 590.4 604.0 7463.2 8026.4 8411.5 8847.5 8893.9 599.4 602.3 611.7 621.6 654.4 3952.2 4086.8 4184.1 4227.6 4235.3 80617.6 82893.0 83088.2 83733.0 85106.1 73728.0 74384.0 75089.6 75165.0 75417.0 63995.4 65152.7 66301.7 67315.3 68091.7 8005.7 8319.1 8359.2 8391.2 8521.2 45160.0 45811.5 46040.5 46165.5 47863.8 58598.0 61670.4 61901.7 61974.4 63889.4 10304.3 10359.6 10519.9 10869.7 10892.0 11544.1 11675.4 11682.6 11768.6 11877.6 11164.2 11243.9 11362.4 11464.8 11757.1 8641.9 11798.8 12045.3 12064.7 12841.6 11995.5 12878.2 12920.4 13152.3 13204.7 9705.2 9727.8 9813.9 9963.7 10461.4 10415.3 10834.4 10956.9 11005.7 11039.4 08:18:42 INFO - PROCESS | 3434 | -------- Summary: end -------- 08:18:42 INFO - PROCESS | 3434 | 08:18:43 INFO - TEST-INFO | 3434: exit 0 08:18:43 INFO - TEST-OK | dromaeo_css | took 1120086ms 08:18:43 INFO - TEST-START | kraken 08:18:43 INFO - operating with platform_type : linux_ 08:18:43 INFO - Initialising browser for kraken test... 08:18:43 INFO - TEST-INFO | started process 3743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo2fQa6/profile http://localhost:37771/getInfo.html) 08:18:47 INFO - PROCESS | 3743 | __metrics Screen width/height:1600/1200 08:18:47 INFO - PROCESS | 3743 | colorDepth:24 08:18:47 INFO - PROCESS | 3743 | Browser inner width/height: 1024/697 08:18:47 INFO - PROCESS | 3743 | __metrics 08:18:48 INFO - PROCESS | 3743 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:18:48 INFO - PROCESS | 3743 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:18:48 INFO - PROCESS | 3743 | console.error: PushService: 08:18:48 INFO - PROCESS | 3743 | stateChangeProcessEnqueue: Error transitioning state 08:18:48 INFO - PROCESS | 3743 | UnknownError 08:18:49 INFO - TEST-INFO | 3743: exit 0 08:18:49 INFO - Browser initialized. 08:18:49 INFO - Running cycle 1/1 for kraken test... 08:18:49 INFO - TEST-INFO | started process 3824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo2fQa6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:01 INFO - PROCESS | 3824 | RSS: Main: 172277760 08:19:01 INFO - PROCESS | 3824 | 08:19:04 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37771/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:05 INFO - PROCESS | 3824 | RSS: Main: 234745856 08:19:05 INFO - PROCESS | 3824 | 08:19:07 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37771/tests/kraken/driver.html?testName=audio-dft) 08:19:08 INFO - PROCESS | 3824 | RSS: Main: 217305088 08:19:08 INFO - PROCESS | 3824 | 08:19:11 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37771/tests/kraken/driver.html?testName=audio-fft) 08:19:11 INFO - PROCESS | 3824 | RSS: Main: 298967040 08:19:11 INFO - PROCESS | 3824 | 08:19:13 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37771/tests/kraken/driver.html?testName=audio-oscillator) 08:19:14 INFO - PROCESS | 3824 | RSS: Main: 210214912 08:19:14 INFO - PROCESS | 3824 | 08:19:16 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37771/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:19:17 INFO - PROCESS | 3824 | RSS: Main: 213893120 08:19:17 INFO - PROCESS | 3824 | 08:19:20 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37771/tests/kraken/driver.html?testName=imaging-darkroom) 08:19:20 INFO - PROCESS | 3824 | RSS: Main: 253448192 08:19:20 INFO - PROCESS | 3824 | 08:19:24 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37771/tests/kraken/driver.html?testName=imaging-desaturate) 08:19:24 INFO - PROCESS | 3824 | RSS: Main: 252932096 08:19:24 INFO - PROCESS | 3824 | 08:19:27 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37771/tests/kraken/driver.html?testName=json-parse-financial) 08:19:28 INFO - PROCESS | 3824 | RSS: Main: 251797504 08:19:28 INFO - PROCESS | 3824 | 08:19:29 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37771/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:19:30 INFO - PROCESS | 3824 | RSS: Main: 213667840 08:19:30 INFO - PROCESS | 3824 | 08:19:32 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37771/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:19:32 INFO - PROCESS | 3824 | RSS: Main: 220569600 08:19:32 INFO - PROCESS | 3824 | 08:19:35 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37771/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:19:36 INFO - PROCESS | 3824 | RSS: Main: 228995072 08:19:36 INFO - PROCESS | 3824 | 08:19:39 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:19:39 INFO - PROCESS | 3824 | RSS: Main: 233590784 08:19:39 INFO - PROCESS | 3824 | 08:19:42 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:19:43 INFO - PROCESS | 3824 | RSS: Main: 235761664 08:19:43 INFO - PROCESS | 3824 | 08:19:44 INFO - PROCESS | 3824 | Cycle 1(1): loaded http://localhost:37771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37771/tests/kraken/driver.html?testName=ai-astar) 08:19:45 INFO - PROCESS | 3824 | RSS: Main: 286736384 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | __start_tp_report 08:19:45 INFO - PROCESS | 3824 | _x_x_mozilla_page_load 08:19:45 INFO - PROCESS | 3824 | _x_x_mozilla_page_load_details 08:19:45 INFO - PROCESS | 3824 | |i|pagename|runs| 08:19:45 INFO - PROCESS | 3824 | |0;ai-astar;113;112;113;113;113;112;114;113;113;111 08:19:45 INFO - PROCESS | 3824 | |1;audio-beat-detection;150;123;124;165;129;126;127;128;141;130 08:19:45 INFO - PROCESS | 3824 | |2;audio-dft;162;161;160;161;161;161;161;161;161;161 08:19:45 INFO - PROCESS | 3824 | |3;audio-fft;75;77;75;101;76;76;76;76;94;76 08:19:45 INFO - PROCESS | 3824 | |4;audio-oscillator;84;83;119;85;84;84;97;85;85;118 08:19:45 INFO - PROCESS | 3824 | |5;imaging-gaussian-blur;128;127;127;127;127;126;127;127;127;127 08:19:45 INFO - PROCESS | 3824 | |6;imaging-darkroom;146;147;146;146;146;147;145;146;145;146 08:19:45 INFO - PROCESS | 3824 | |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;95 08:19:45 INFO - PROCESS | 3824 | |8;json-parse-financial;54;53;54;55;55;55;54;54;55;54 08:19:45 INFO - PROCESS | 3824 | |9;json-stringify-tinderbox;63;63;63;63;63;64;63;62;63;64 08:19:45 INFO - PROCESS | 3824 | |10;stanford-crypto-aes;90;89;82;82;82;81;81;80;80;82 08:19:45 INFO - PROCESS | 3824 | |11;stanford-crypto-ccm;137;147;132;142;140;134;133;140;221;130 08:19:45 INFO - PROCESS | 3824 | |12;stanford-crypto-pbkdf2;168;169;168;168;170;171;169;178;170;168 08:19:45 INFO - PROCESS | 3824 | |13;stanford-crypto-sha256-iterative;64;65;65;64;67;69;65;68;65;67 08:19:45 INFO - PROCESS | 3824 | __end_tp_report 08:19:45 INFO - PROCESS | 3824 | __start_cc_report 08:19:45 INFO - PROCESS | 3824 | _x_x_mozilla_cycle_collect,1687 08:19:45 INFO - PROCESS | 3824 | __end_cc_report 08:19:45 INFO - PROCESS | 3824 | __startTimestamp1481818785141__endTimestamp 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | ------- Summary: start ------- 08:19:45 INFO - PROCESS | 3824 | Number of tests: 14 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 08:19:45 INFO - PROCESS | 3824 | Values: 113.0 112.0 113.0 113.0 113.0 112.0 114.0 113.0 113.0 111.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:129.50 stddev:13.65 (10.5%) stddev-sans-first:13.24 08:19:45 INFO - PROCESS | 3824 | Values: 150.0 123.0 124.0 165.0 129.0 126.0 127.0 128.0 141.0 130.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 08:19:45 INFO - PROCESS | 3824 | Values: 162.0 161.0 160.0 161.0 161.0 161.0 161.0 161.0 161.0 161.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.00 stddev:9.28 (12.2%) stddev-sans-first:9.65 08:19:45 INFO - PROCESS | 3824 | Values: 75.0 77.0 75.0 101.0 76.0 76.0 76.0 76.0 94.0 76.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:84.50 stddev:14.33 (17.0%) stddev-sans-first:14.87 08:19:45 INFO - PROCESS | 3824 | Values: 84.0 83.0 119.0 85.0 84.0 84.0 97.0 85.0 85.0 118.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#5] imaging-gaussian-blur Cycles:10 Average:127.00 Median:127.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 08:19:45 INFO - PROCESS | 3824 | Values: 128.0 127.0 127.0 127.0 127.0 126.0 127.0 127.0 127.0 127.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:19:45 INFO - PROCESS | 3824 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 145.0 146.0 145.0 146.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:19:45 INFO - PROCESS | 3824 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:0.67 (1.2%) stddev-sans-first:0.71 08:19:45 INFO - PROCESS | 3824 | Values: 54.0 53.0 54.0 55.0 55.0 55.0 54.0 54.0 55.0 54.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 08:19:45 INFO - PROCESS | 3824 | Values: 63.0 63.0 63.0 63.0 63.0 64.0 63.0 62.0 63.0 64.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:3.57 (4.4%) stddev-sans-first:2.71 08:19:45 INFO - PROCESS | 3824 | Values: 90.0 89.0 82.0 82.0 82.0 81.0 81.0 80.0 80.0 82.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:140.00 stddev:26.99 (19.3%) stddev-sans-first:28.45 08:19:45 INFO - PROCESS | 3824 | Values: 137.0 147.0 132.0 142.0 140.0 134.0 133.0 140.0 221.0 130.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:169.50 stddev:3.03 (1.8%) stddev-sans-first:3.14 08:19:45 INFO - PROCESS | 3824 | Values: 168.0 169.0 168.0 168.0 170.0 171.0 169.0 178.0 170.0 168.0 08:19:45 INFO - PROCESS | 3824 | 08:19:45 INFO - PROCESS | 3824 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.73 (2.6%) stddev-sans-first:1.69 08:19:45 INFO - PROCESS | 3824 | Values: 64.0 65.0 65.0 64.0 67.0 69.0 65.0 68.0 65.0 67.0 08:19:45 INFO - PROCESS | 3824 | -------- Summary: end -------- 08:19:45 INFO - PROCESS | 3824 | 08:19:46 INFO - TEST-INFO | 3824: exit 0 08:19:46 INFO - TEST-OK | kraken | took 62718ms 08:19:46 INFO - SUITE-END | took 1182s 08:19:46 INFO - Completed test suite (00:19:42) 08:19:46 INFO - javascript benchmark 08:19:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3006.954895676565, 3025.213444504428, 3058.235441139715, 3061.494853349196, 3068.0642404066753, 5161.9741901290445, 5195.896082078366, 5196.9480305196985, 5200.271961925324, 5263.447338029509, 5147.1764517677175, 5178.870528236796, 5181.378234611842, 5244.921326180101, 5276.445973172828, 4775.4985726498735, 4779.259214821708, 4816.723568254415, 4818.807247710088, 4837.4195096588455, 4814.9759251203695, 4827.589654879322, 4864.7324397158145, 4898.828541001048, 4909.386326709161, 4854.36893203883, 4854.58736007438, 4873.195922672772, 4893.14369985253, 4908.7300198489065, 4745.59662428694, 4749.026449577863, 4768.070226305872, 4840.15297322967, 4877.365942427497, 4726.007538416937, 4739.0, 4759.048190361941, 4786.377770889762, 4836.371271734687, 5213.869653258661, 5221.843344699665, 5232.581393488512, 5254.527092561688, 5308.893822123575, 5481.424450432727, 5618.606697531174, 5621.072523033695, 5623.662580245198, 5626.099824028136, 5530.391656917735, 5542.002439560877, 5543.972280138614, 5558.194061861048, 5650.971745141248, 5233.215017747369, 5233.5551478124025, 5234.110201265794, 5235.816746413857, 5238.659487133325, 5693.857653558612, 5694.08894576874, 5704.0, 5710.086386178192, 5750.654960702372, 5421.349438067378, 5437.048516509595, 5473.808416705396, 5476.58925580583, 5480.0, 5543.36251331094, 5553.0, 5576.0, 5579.358373786985, 5657.858553536113, 5513.972430137824, 5566.972165139229, 5567.192757050205, 5576.191452239403, 5584.246126772834, 5478.91781623276, 5494.642848214853, 5495.53287970527, 5556.472135147154, 5605.32736071674, 4350.042990542076, 4402.163588918095, 4404.757738324423, 4409.096135292258, 4412.558744125626, 3921.8235179416993, 3924.6271604198128, 3930.665893399036, 3964.444977703124, 3975.7614543127506, 5428.864278393072, 5430.511253987082, 5432.51107400328, 5436.755346009439, 5481.177823326453, 5480.534154596904, 5514.28314319144, 5545.085060964976, 5581.134924086773, 5688.089905615082, 5295.0, 5345.278387417727, 5385.27298814655, 5385.407605163429, 5385.649932754359, 4881.072596206709, 4881.682690625098, 4885.926711099336, 4909.361782968263, 4924.162892308244, 5735.655860648374, 5795.043817770021, 5805.970970145122, 5808.041673123972, 5808.970955145197, 5487.122060470306, 5503.3395992481155, 5505.064139096443, 5505.201745746925, 5556.944180605672, 5755.769769209185, 5766.4233576642, 5767.942320576908, 5796.94203057964, 5813.128030795415, 5562.5549956002615, 5569.08110161835, 5573.5819813513335, 5578.693171875586, 5579.637323573955, 5464.2076898848645, 5495.340559132929, 5607.495325420732, 5610.579206559442, 5653.067243904709, 5428.0, 5460.7542660579575, 5469.15228139639, 5469.699166545719, 5472.835814925558, 5440.7551660174595, 5445.727713614224, 5449.564034877121, 5466.234727138283, 5469.288992430958, 5368.436314186954, 5407.810726624549, 5410.215518749838, 5412.269343638558, 5415.0, 5505.284313039279, 5524.640898341595, 5529.751161197675, 5534.584906131976, 5537.169424586345, 5455.372632147354, 5457.945420545744, 5459.12653975362, 5475.863103422446, 5478.506934375766], "value": 5180.957949457214, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.588864240462, 576.3688760806917, 589.4518098168704, 590.9911351329731, 597.2027343496432, 31356.216094597647, 38461.615383846154, 40580.391294130575, 40727.185456290856, 43828.3425748614, 42282.0, 42573.36139957903, 42685.14629707404, 42702.35946460798, 42705.0, 7804.843903121934, 8635.438696484724, 8831.337649676268, 8834.337424693142, 8834.425762325429, 7833.21667833215, 8046.517208967452, 8051.637676304551, 10054.447005414699, 10323.225758068138, 10413.21900857435, 10468.16254699626, 10473.581056757721, 10478.37129772216, 10482.633107841228, 10254.333468324572, 10313.07182353588, 10315.948420257926, 10322.793544129076, 10328.690139295833, 10221.744456388575, 10243.487825608765, 10284.691459256233, 10290.485475726258, 10291.588336466531, 40588.39117413211, 40673.79663101665, 40889.0, 40904.79547602273, 40952.180956380704, 2978.3596526746637, 3254.886078987248, 3318.4026875162463, 3332.216929021678, 3575.7496975211748, 25836.74163258362, 27009.729902701114, 27356.863215683992, 27481.31296717578, 28410.71589284122, 4134.896627584304, 4149.751014939114, 4164.371597715347, 4195.475565554306, 4253.957460425387, 308356.0, 309194.0, 309973.9540371246, 310862.0, 310870.0, 50103.0, 50187.74906125446, 50199.498005020214, 50220.9823214142, 50293.74853125711, 51644.74177629163, 51734.482655172964, 51753.96492070137, 52142.217866732026, 52156.739216304435, 14422.639434014234, 14910.701785964437, 14916.776248356284, 14918.0, 14931.178785166703, 9440.339176257734, 11610.187286889837, 11773.058155347551, 11773.52905883755, 11775.587854425054, 14586.562403127924, 16426.917865410596, 16570.420035298946, 16664.83335166657, 17204.91397543004, 6422.229332480132, 6431.356864313531, 6492.837679058061, 6547.541672082908, 6599.47204223661, 860.8493513635088, 980.8038392321564, 983.3902980152351, 1069.8395240713799, 1096.8628921384827, 30755.538666920012, 30772.846135769178, 30879.536806947915, 31030.68969310278, 31427.84286078555, 1025.0518270599666, 1078.229066217658, 1090.3893819461127, 1133.982990255147, 1159.652104368686, 15755.212239387985, 16217.675646487005, 16298.67402651964, 16328.34686612546, 16654.50036498907, 538518.0, 541351.0, 543338.0, 543605.0, 543993.0, 54799.72600137054, 55226.3057640097, 55232.44767552354, 55234.447655522934, 55314.446855531736, 1283.3390803736083, 1314.3822403470544, 1323.0275747325709, 1323.1664051647401, 1326.6683329167709, 27508.312292192855, 29228.0, 29904.401911962075, 29928.25179370446, 30580.541291881083, 48698.26952595643, 49250.75374623104, 49296.0, 49360.75319623522, 49374.25938610995, 408747.0, 411467.0, 417631.0, 420049.0, 420711.0, 24450.51098978046, 25030.62454063154, 26252.0, 27031.72968270292, 27609.171724848286, 41781.58218417777, 43578.34632480579, 43831.34252986144, 44940.55059449364, 45341.77329113333, 37162.628373717, 38057.4291385635, 38564.6143538561, 38972.0, 40024.7998760016, 37713.62286377101, 37904.620953791215, 37933.0, 38200.808995954845, 38479.61520384761, 35320.0, 35646.82176589101, 35836.28327433489, 38219.61780382161, 38374.23251534898, 29384.706152939052, 32693.836530817192, 32742.0, 32754.344913102083, 32867.0, 24099.397515062265, 24741.381465463506, 24829.751702483467, 25196.370090747143, 25223.495530088927], "value": 19027.213961876834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.5316335600362, 370.3740678253751, 375.5737238234603, 385.5604610743752, 398.3506883779441, 14036.157830530163, 17189.656206875854, 18062.729059064124, 19097.809021909776, 19267.22931082755, 17507.47477575675, 18027.36904208353, 18109.4567162985, 18253.634927301446, 18606.16272267748, 4993.325901003354, 5241.371035475749, 5263.815766448175, 5269.604779641523, 5272.367315922094, 3776.1126135358304, 4288.7212331198525, 5147.459516750743, 5233.0, 5237.3715154181555, 4335.176316499871, 6345.619262844221, 6372.808815735535, 6443.9355606443805, 6450.4839612830865, 5743.913841292384, 5749.108888122348, 6221.160143380631, 6440.871182576346, 6443.033544968245, 5593.8321850344555, 5599.300087489064, 5604.859878503029, 5606.971965140189, 5607.130894711327, 13449.394777235048, 19818.60362792736, 21451.892740536354, 22051.889740551356, 22205.77794222053, 2083.2500299892026, 2120.703101565782, 2192.572448372568, 2267.7278726552754, 2375.5011447596025, 8071.434999550034, 9338.813223735488, 9339.392939458981, 10259.230557708128, 10308.32995855267, 1850.4078694817663, 1883.1808163448807, 1896.6680830854546, 1959.1575622482326, 1959.2652755216793, 68438.04991201434, 76578.61710691467, 77111.22888771097, 78454.0, 79498.99999999942, 10431.94784026075, 10556.577736890593, 10681.83977240342, 10814.675559733221, 10898.237123401444, 14981.951263411675, 15009.774853377208, 15018.624534386508, 15021.849781502264, 15044.924775376272, 7374.446916481285, 7722.6910923563555, 7761.534307941542, 7905.644246008944, 7929.484583502054, 7243.420526357879, 7265.346118849223, 7271.854562908712, 7536.434767392468, 7570.886436703454, 4520.932186017212, 4578.702384345007, 4604.953950460519, 4611.608013318838, 4627.519193857933, 1787.2136260045538, 1833.0839848700955, 1847.353426300784, 1930.6331796958532, 1946.8442524598, 800.7197480881762, 876.8071024374627, 909.7952960583948, 925.8703781470599, 950.5247376311844, 16952.253369056685, 18708.719369209473, 18903.338383156522, 19086.52283692891, 19278.22887084529, 874.9781255468537, 890.2388457868559, 936.5364144748393, 940.1303793990668, 952.4333021851987, 9802.313838031268, 10471.0, 10584.707646176912, 10597.682069537772, 10623.20325975555, 357130.0, 394600.0, 396882.0, 397057.0, 398901.0, 62075.6896215516, 76768.61615691886, 82411.0, 84218.0, 89419.55290223638, 947.7677968897664, 976.9853452198223, 985.6353149334649, 998.5157198758596, 1000.2198285337448, 16069.910911581419, 16211.432599858948, 16497.010179389275, 16682.416115435903, 16869.91565042167, 39409.80295098506, 39544.2091158181, 40423.59576404198, 40547.1890562193, 40970.79514602408, 55035.0, 55351.72324138354, 56269.155962659774, 56368.0, 56391.15413268886, 7766.650500727368, 8076.232757887991, 8172.468789528662, 8235.588220589067, 8423.368247381593, 8951.552422378725, 9190.770230744285, 11578.421078946187, 12212.206206596542, 12228.755424891275, 6866.416354609714, 10090.747731306483, 10337.9483102584, 10500.632477863239, 10668.0, 10537.209709271681, 10844.40355780408, 10915.0, 10935.83596246073, 11676.357800321064, 10383.636572719919, 10546.26176167661, 10552.472376380996, 10912.727181820517, 11066.723331916444, 7752.728654497066, 7859.764207073797, 7872.724454644289, 7880.487768295043, 8115.675372985014, 9844.60621575129, 10081.747956301151, 10118.443485608363, 10169.694909152737, 10301.793964120525], "value": 8582.59119759997, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.9584812455628, 1418.5957002254354, 1505.5709122899975, 1678.3118921242294, 1700.4643537285763, 7192.136943566767, 7429.8885516717155, 7738.419618528612, 8195.180481951802, 8198.836023279531, 7741.341985931189, 7990.560519171443, 7991.9600401997905, 8176.182381761821, 8184.959075204616, 2226.8886555672234, 2259.288324177887, 2260.8530445520987, 2263.7849404306567, 2266.8526545774553, 1967.2819420911335, 2031.786662400449, 2198.428408613764, 2230.453538882976, 2236.7539570647214, 2127.0, 2188.89055547222, 2198.5383069555332, 2198.9560208795815, 2209.94475138122, 2197.088208393515, 2204.7244094488187, 2209.679596458521, 2212.6127927612765, 2224.410531209231, 2198.7251593550805, 2200.7579166291694, 2221.711177546925, 2230.6988556544984, 2233.932982010542, 7930.563818989954, 8111.918880811176, 8131.390145739093, 8134.0, 8136.552489613069, 4777.355057067321, 5004.374453193351, 5004.449510553836, 5005.474425185376, 5007.4241462231585, 3191.457452233126, 3237.2877966847254, 3311.6688331166933, 3325.1853295942406, 3344.5317655528247, 1050.2490719135778, 1050.7373156710823, 1106.0653747583278, 1114.4650567727456, 1134.4384529657873, 11000.339979601169, 11002.394868282241, 11038.337699738042, 11042.171837112168, 11046.613368532062, 4118.19695159447, 4275.209086319041, 4344.869653910388, 4381.277089280296, 4407.713498622579, 9315.627374905063, 9455.243580513543, 9480.478573678376, 9483.810323793623, 9494.525273736286, 4835.903281934342, 4874.975625121851, 4911.0, 4915.778789954461, 5024.0956627807345, 4308.224519586504, 4499.122671079108, 4502.662300327489, 4504.572065653758, 4589.33454649074, 3578.6958108560543, 3697.5008373869723, 3704.666320124753, 3737.551493820759, 3797.4493698414126, 1075.575147816608, 1100.2463312630873, 1186.5609724401854, 1200.6398080575793, 1220.5117952818944, 845.2730651639584, 869.9391042626955, 896.5606852642159, 926.5598840550684, 935.1209862729013, 5306.6550674206055, 5391.029614669319, 5637.548996080303, 5668.376478587352, 5796.304443466811, 930.2883294279882, 938.3994243684048, 959.947202903833, 961.5000199896015, 988.3790583443159, 3893.3575959966856, 3922.7057970652313, 3950.565437801897, 3967.0677390813134, 3984.163325701635, 9606.759831004281, 10042.799144017079, 10051.597936082475, 10052.64815731446, 10063.39619622825, 9897.059779320953, 9967.0, 9968.302218844756, 9974.501274936369, 9994.150497207673, 7319.34125928669, 7463.776086717407, 7520.0, 7629.618519074135, 7633.69465221385, 5472.261244731911, 5518.199861020049, 5559.805406810742, 5696.174054761954, 5705.172749951151, 8838.513881736566, 8882.111788821067, 8908.955455222682, 8917.464952102895, 8935.463872167691, 8531.616077276662, 9154.954225229098, 9194.31042671789, 9211.124943130391, 9270.582823772811, 7279.27207279289, 7531.3598344141365, 7626.923730762622, 7671.961640191764, 7677.117131529945, 7414.258574142543, 7640.617969101411, 7672.769816905502, 7713.7685869424, 7724.729634462767, 5706.543476521952, 6632.668366581748, 6898.206706228647, 7060.188078371053, 7100.964495177491, 6797.320267973163, 6804.9319506804295, 6879.380855723009, 7079.327463890922, 7192.856142877218, 6328.240611126695, 6359.650219237801, 6366.64983425916, 6453.032045193258, 6483.805485835433, 4508.571685689854, 4540.114677637829, 4696.647751418725, 4842.4189097308545, 4855.878603034952, 4750.548697873696, 4793.089313030513, 4904.068227036852, 4914.533119353656, 4930.605551555938], "value": 4317.395178889187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.60617078018714, 348.7489007914304, 355.1281603663009, 358.6270278909933, 363.6690611543495, 5068.898622027557, 5076.137101289847, 5095.872603184922, 5102.872428189297, 5155.71643559604, 5078.0, 5109.923351149736, 5110.56904066861, 5110.718910459923, 5131.871703207422, 3919.3533067044045, 4024.29574824406, 4049.574794646549, 4064.870050061451, 4064.9390259146135, 3980.4825372701507, 4018.899527511821, 4039.919201615966, 4045.1909618076356, 4073.551909289976, 4023.6781057515327, 4029.1941611677635, 4044.5348784889675, 4048.4736984192014, 4049.777262250575, 4025.4364388985564, 4026.5973402659793, 4055.1281474482835, 4056.837726490937, 4077.674755704378, 3420.8973730788116, 3486.2853115111343, 3487.4768784682246, 3527.982360088183, 3704.7036237100965, 4995.625328100407, 4996.325496058058, 5000.849974500771, 5005.174146265898, 5033.370828646419, 4670.921439959219, 4679.60223381013, 4681.812727490897, 4690.484046754854, 4698.953010469886, 5160.974195129038, 5310.415854256029, 5342.358916929993, 5342.786288548454, 5351.2240725095035, 3970.4242884781834, 4005.0, 4010.859619913289, 4023.8591649292134, 4029.7582145071096, 5506.587005974568, 5542.224088627595, 5550.4449555044575, 5567.610267281292, 5589.441055894459, 4042.2319759245647, 4096.836126554964, 4099.262132816062, 4120.670346372283, 4153.833846646161, 4148.896277593084, 4161.313383291784, 4162.396452514429, 4179.2477354076555, 4183.686223533186, 4653.092646933816, 4667.136579732693, 4676.275177347517, 4677.976610116928, 4686.507916668769, 5256.553192978563, 5356.758945847446, 5414.620976531605, 5443.972780136074, 5452.100403433468, 1398.6363545478248, 1410.8659677330638, 1413.2086031822212, 1419.6158745223531, 1425.7861320801755, 953.4041224234853, 1005.0903931941605, 1017.2523195451338, 1018.7809620931536, 1019.5513973851481, 5070.29015937769, 5090.898182036339, 5109.463506331856, 5127.820526281562, 5130.769115389817, 5302.973485132549, 5338.0, 5394.649347792381, 5415.323084614423, 5542.972285138549, 5223.921641175385, 5225.190095535198, 5251.238570407269, 5267.341582302212, 5268.81559145428, 2714.1586108306487, 2823.647044119485, 2842.928926776847, 2844.985775071111, 2848.2167403964077, 5442.863928401743, 5472.5348345391085, 5498.532624726943, 5545.861353466195, 5552.944470555323, 5393.952416884447, 5411.377691565442, 5426.751847075195, 5458.335207761592, 5464.617476776588, 5324.8136315228785, 5479.643823151482, 5490.835274941678, 5493.945060549343, 5519.227308176778, 5306.97346513265, 5322.228276899906, 5326.813561525328, 5331.973340133274, 5350.8127215547265, 5283.947160528499, 5341.985022845647, 5356.089464791073, 5365.248865158959, 5382.703951282717, 5240.764165612481, 5441.83674489766, 5478.91781623268, 5497.8075767347955, 5558.722063896708, 4079.6124368184974, 4080.163566468926, 4081.6734661227624, 4098.7950602470355, 4101.8974525637095, 5367.0, 5403.7838486460105, 5404.784153428704, 5423.637344846221, 5427.457254274699, 5122.667026643257, 5218.921716174336, 5222.582193424593, 5252.606054546, 5285.497877701766, 5182.714950677598, 5195.558377537952, 5199.92200116991, 5201.219817027476, 5241.528262456397, 5038.722870242172, 5166.328377310925, 5202.791888324425, 5211.166213405989, 5218.373795144607, 5177.896442071213, 5181.611379146504, 5208.348956380452, 5231.476852314738, 5290.523852853262, 5019.799208031784, 5114.15616423286, 5123.897522049613, 5210.869728256824, 5288.762005709829], "value": 4109.499788157122, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.1262857256991, 670.1756839087925, 690.7893092606756, 695.9721611135554, 742.9739959101429, 13748.106373085742, 14883.330250138742, 14889.329980150893, 15074.698506029887, 15075.246237688112, 13833.861661383384, 14075.859241407583, 14082.71834563308, 14082.859171408283, 14090.0, 673.4679603113534, 693.8612277544486, 793.9523628582289, 809.0655293136437, 810.6878851642131, 780.7501599488166, 803.1165717710501, 813.975580732576, 815.7063457155419, 816.9183081691813, 850.3324889961382, 851.642310229705, 852.2329903087209, 854.5214679779313, 855.2260204514893, 697.8464737757686, 717.0928775099503, 848.5205858689851, 849.0066622052183, 849.027863096757, 532.1963834609728, 532.4861508644177, 596.7314708381246, 612.9908051379233, 619.4734475695668, 13798.862011379859, 13839.238841863693, 13840.792388114187, 13844.30778461083, 13850.16898986064, 11094.167937404727, 11198.552057917674, 11282.605108821233, 11337.773244535063, 11793.997510211642, 12111.62882918603, 12137.297409922734, 12220.816687749691, 12222.0, 12301.446434910451, 4126.979365103155, 4165.354370072643, 4175.62419382254, 4200.409626723926, 4313.654907607384, 71976.280237198, 72742.63628681823, 74809.62595187043, 75136.87294690638, 75865.0, 9308.255339572817, 9530.285228607881, 9548.90451095494, 9582.472963986907, 10278.33190842593, 17310.65378692419, 17312.394066207624, 17313.134343283036, 17336.3065477382, 17397.217125229396, 7723.65243564041, 7799.0, 7829.843403131906, 7898.01274840645, 7921.603919803987, 4241.703080784378, 4244.3209086546, 4351.8694439166875, 4371.409859668904, 4417.293233082692, 3170.9682903170674, 3241.7406607471344, 3242.0760083376595, 3245.3509298140466, 3257.2671148991762, 561.9775208991676, 566.9461401166883, 567.4354017752363, 589.9085641725453, 595.9642421454727, 535.0476152448648, 574.9540036797047, 575.3153747041008, 590.3742033444563, 603.9698015099316, 7463.216362281991, 8026.38320309187, 8411.537365444838, 8847.513386763661, 8893.866592000995, 599.4395240450193, 602.3284038297267, 611.6910959965278, 621.6177051113533, 654.3685343643407, 3952.150287688161, 4086.7752273625238, 4184.14225083857, 4227.640650544677, 4235.322348424237, 80617.59691201507, 82893.0, 83088.16911830925, 83733.0, 85106.14893850982, 73728.0, 74384.0, 75089.62455187688, 75165.0, 75417.0, 63995.360046400805, 65152.67423662851, 66301.66849165723, 67315.32684673091, 68091.65954170296, 8005.679772809255, 8319.126491718282, 8359.205875441823, 8391.202835730595, 8521.190486903733, 45160.0, 45811.54188458073, 46040.53959460497, 46165.53834461747, 47863.76068119637, 58598.0, 61670.38329616647, 61901.690491547255, 61974.38025619867, 63889.36110638834, 10304.330218535772, 10359.585616575554, 10519.947400263256, 10869.67390978272, 10892.0, 11544.054662443354, 11675.35785531804, 11682.649520514398, 11768.58809941648, 11877.58428455, 11164.218504704593, 11243.887302966365, 11362.375069370933, 11464.82802757976, 11757.118216133653, 8641.8703719443, 11798.764024719287, 12045.33750643723, 12064.698382540506, 12841.550545730855, 11995.460204290654, 12878.227306361649, 12920.35398230066, 13152.342382881008, 13204.735905282032, 9705.223582113273, 9727.756806079622, 9813.85279220798, 9963.651272205438, 10461.424621645883, 10415.323004004715, 10834.404107774148, 10956.86737075833, 11005.669829905115, 11039.448027598748], "value": 6709.182040735711, "unit": "score"}], "name": "dromaeo_css", "value": 6821.109855820608, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 113.0, 113.0, 112.0, 114.0, 113.0, 113.0, 111.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 124.0, 165.0, 129.0, 126.0, 127.0, 128.0, 141.0, 130.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 101.0, 76.0, 76.0, 76.0, 76.0, 94.0, 76.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 119.0, 85.0, 84.0, 84.0, 97.0, 85.0, 85.0, 118.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 127.0, 127.0, 127.0, 126.0, 127.0, 127.0, 127.0, 127.0], "value": 127.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 82.0, 82.0, 82.0, 81.0, 81.0, 80.0, 80.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 147.0, 132.0, 142.0, 140.0, 134.0, 133.0, 140.0, 221.0, 130.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 168.0, 168.0, 170.0, 171.0, 169.0, 178.0, 170.0, 168.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 67.0, 69.0, 65.0, 68.0, 65.0, 67.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1530.5000000000002, "alertThreshold": 2.0}]} 08:19:46 INFO - Return code: 0 08:19:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:19:46 INFO - # TBPL SUCCESS # 08:19:46 INFO - Running post-action listener: _resource_record_post_action 08:19:46 INFO - [mozharness: 2016-12-15 16:19:46.433047Z] Finished run-tests step (success) 08:19:46 INFO - Running post-run listener: _resource_record_post_run 08:19:46 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8159232; Write bytes: 414507008; Read time: 2192; Write time: 397588 08:19:46 INFO - TinderboxPrint: CPU usage
13.2% 08:19:46 INFO - TinderboxPrint: I/O read bytes / time
8,159,232 / 2,192 08:19:46 INFO - TinderboxPrint: I/O write bytes / time
414,507,008 / 397,588 08:19:46 INFO - TinderboxPrint: CPU idle
8,306.3 (86.7%) 08:19:46 INFO - TinderboxPrint: CPU user
1,213.6 (12.7%) 08:19:46 INFO - TinderboxPrint: Swap in / out
0 / 0 08:19:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 92368896; Read time: 240; Write time: 77016 08:19:46 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 5718016; Write bytes: 322138112; Read time: 1728; Write time: 320572 08:19:47 INFO - Running post-run listener: _upload_blobber_files 08:19:47 INFO - Blob upload gear active. 08:19:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:19:47 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 08:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:19:47 INFO - (blobuploader) - INFO - Open directory for files ... 08:19:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:19:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:19:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:51 INFO - (blobuploader) - INFO - Done attempting. 08:19:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:19:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:19:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:52 INFO - (blobuploader) - INFO - Done attempting. 08:19:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:19:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:19:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:53 INFO - (blobuploader) - INFO - Done attempting. 08:19:53 INFO - (blobuploader) - INFO - Iteration through files over. 08:19:53 INFO - Return code: 0 08:19:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:19:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:19:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbe17fd331074db7c3669a5988ba9cbd77a95c13d24665a495aaeda4d20194655fe529201346b33363497b0211f43b16f0ee412011fcdbb6e99361a3c212d204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc4635a030a7af738a4b2ee03599cef1991984c31b7b9e8c2b4913fd9d36ada3ca812972a7a213a6c10d0a2728aa3d1b0467370aad6611e382f96448c4079867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9382054df398ef7feac14897f39d495ca6b275788ef22d683df303faeb299d7cb69fc74d52360bc79798e20c47bcbcfbc42b9895939b941957b56483f9101f43"} 08:19:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:19:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:19:53 INFO - Contents: 08:19:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbe17fd331074db7c3669a5988ba9cbd77a95c13d24665a495aaeda4d20194655fe529201346b33363497b0211f43b16f0ee412011fcdbb6e99361a3c212d204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc4635a030a7af738a4b2ee03599cef1991984c31b7b9e8c2b4913fd9d36ada3ca812972a7a213a6c10d0a2728aa3d1b0467370aad6611e382f96448c4079867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9382054df398ef7feac14897f39d495ca6b275788ef22d683df303faeb299d7cb69fc74d52360bc79798e20c47bcbcfbc42b9895939b941957b56483f9101f43"} 08:19:53 INFO - Running post-run listener: copy_logs_to_upload_dir 08:19:53 INFO - Copying logs to upload dir... 08:19:53 INFO - mkdir: /builds/slave/test/build/upload/logs 08:19:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.348132 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-15 08:19:54.036916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 08:19:54.044250) ========= 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=03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbe17fd331074db7c3669a5988ba9cbd77a95c13d24665a495aaeda4d20194655fe529201346b33363497b0211f43b16f0ee412011fcdbb6e99361a3c212d204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc4635a030a7af738a4b2ee03599cef1991984c31b7b9e8c2b4913fd9d36ada3ca812972a7a213a6c10d0a2728aa3d1b0467370aad6611e382f96448c4079867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9382054df398ef7feac14897f39d495ca6b275788ef22d683df303faeb299d7cb69fc74d52360bc79798e20c47bcbcfbc42b9895939b941957b56483f9101f43"} build_url:https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011603 build_url: 'https://queue.taskcluster.net/v1/task/N6G8UwawRne10XSvf87sFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbe17fd331074db7c3669a5988ba9cbd77a95c13d24665a495aaeda4d20194655fe529201346b33363497b0211f43b16f0ee412011fcdbb6e99361a3c212d204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc4635a030a7af738a4b2ee03599cef1991984c31b7b9e8c2b4913fd9d36ada3ca812972a7a213a6c10d0a2728aa3d1b0467370aad6611e382f96448c4079867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9382054df398ef7feac14897f39d495ca6b275788ef22d683df303faeb299d7cb69fc74d52360bc79798e20c47bcbcfbc42b9895939b941957b56483f9101f43"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 08:19:54.071762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 08:19:54.075116) ========= 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=03627c79f6bb3d1578c4a402000001ba-1481816080.666588-1657280838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004673 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 08:19:54.348235) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 08:19:54.348552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 08:19:54.348937) ========= ========= Total master_lag: 0.81 =========