builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1486638984.4 results: success (0) revision: 7bab8cf2a1cf936aeeceb61d8f791ff8f4e9223b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:24.395922) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:24.396310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:24.396575) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:24.412347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:24.412599) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 03:16:25-- 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% 88.0M=0s 2017-02-09 03:16:25 (88.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.205942 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:24.631642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:24.631950) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014319 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:24.680458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 03:16:24.680757) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7bab8cf2a1cf936aeeceb61d8f791ff8f4e9223b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7bab8cf2a1cf936aeeceb61d8f791ff8f4e9223b --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=e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 03:16:25,594 truncating revision to first 12 chars 2017-02-09 03:16:25,594 Setting DEBUG logging. 2017-02-09 03:16:25,594 attempt 1/10 2017-02-09 03:16:25,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7bab8cf2a1cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 03:16:26,811 unpacking tar archive at: mozilla-aurora-7bab8cf2a1cf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.536324 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 03:16:26.322036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:26.322349) ========= script_repo_revision: 7bab8cf2a1cf936aeeceb61d8f791ff8f4e9223b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:26.322735) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:26.323027) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 03:16:26.333005) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-09 03:16:26.333298) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:16:27 INFO - MultiFileLogger online at 20170209 03:16:27 in /builds/slave/test 03:16:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 03:16:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:16:27 INFO - {'append_to_log': False, 03:16:27 INFO - 'base_work_dir': '/builds/slave/test', 03:16:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 03:16:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:16:27 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 03:16:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:27 INFO - 'config_files': ('talos/linux_config.py',), 03:16:27 INFO - 'default_actions': ('clobber', 03:16:27 INFO - 'read-buildbot-config', 03:16:27 INFO - 'download-and-extract', 03:16:27 INFO - 'populate-webroot', 03:16:27 INFO - 'create-virtualenv', 03:16:27 INFO - 'install', 03:16:27 INFO - 'run-tests'), 03:16:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:27 INFO - 'download_minidump_stackwalk': True, 03:16:27 INFO - 'download_symbols': 'ondemand', 03:16:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:27 INFO - 'installer_path': 'installer.exe', 03:16:27 INFO - 'log_level': 'info', 03:16:27 INFO - 'log_name': 'talos', 03:16:27 INFO - 'log_to_console': True, 03:16:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:16:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:16:27 INFO - 'opt_config_files': (), 03:16:27 INFO - 'pip_index': False, 03:16:27 INFO - 'sps_profile': False, 03:16:27 INFO - 'sps_profile_interval': 0, 03:16:27 INFO - 'suite': 'dromaeojs', 03:16:27 INFO - 'system_bits': '32', 03:16:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:27 INFO - 'title': 'talos-linux64-ix-067', 03:16:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:27 INFO - 'use_talos_json': True, 03:16:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:16:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:27 INFO - 'work_dir': 'build'} 03:16:27 INFO - [mozharness: 2017-02-09 11:16:27.340670Z] Running clobber step. 03:16:27 INFO - Running pre-action listener: _resource_record_pre_action 03:16:27 INFO - Running main action method: clobber 03:16:27 INFO - rmtree: /builds/slave/test/build 03:16:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:16:27 INFO - Running post-action listener: _resource_record_post_action 03:16:27 INFO - [mozharness: 2017-02-09 11:16:27.815766Z] Finished clobber step (success) 03:16:27 INFO - [mozharness: 2017-02-09 11:16:27.815867Z] Running read-buildbot-config step. 03:16:27 INFO - Running pre-action listener: _resource_record_pre_action 03:16:27 INFO - Running main action method: read_buildbot_config 03:16:27 INFO - Using buildbot properties: 03:16:27 INFO - { 03:16:27 INFO - "project": "", 03:16:27 INFO - "product": "firefox", 03:16:27 INFO - "who": "cbook@mozilla.com", 03:16:27 INFO - "installer_path": "public/build/target.tar.bz2", 03:16:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:16:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 03:16:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 03:16:27 INFO - "stage_platform": "linux64", 03:16:27 INFO - "basedir": "/builds/slave/test", 03:16:27 INFO - "buildnumber": 27, 03:16:27 INFO - "platform": "ubuntu64_hw", 03:16:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:16:27 INFO - "slavebuilddir": "test", 03:16:27 INFO - "taskId": "SBY7ALTqQR2_wGH8ad_72g", 03:16:27 INFO - "branch": "mozilla-aurora", 03:16:27 INFO - "script_repo_revision": "production", 03:16:27 INFO - "revision": "7bab8cf2a1cf936aeeceb61d8f791ff8f4e9223b", 03:16:27 INFO - "slavename": "talos-linux64-ix-067", 03:16:27 INFO - "repo_path": "releases/mozilla-aurora" 03:16:27 INFO - } 03:16:27 INFO - Finding installer, test and symbols from parent task. 03:16:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SBY7ALTqQR2_wGH8ad_72g'}, attempt #1 03:16:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SBY7ALTqQR2_wGH8ad_72g'}, attempt #1 03:16:28 INFO - Task dependencies: A0QRacE4SL6o3ZIeILfrYQ 03:16:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ'}, attempt #1 03:16:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.tar.bz2 03:16:29 INFO - Set test_url: https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/test_packages.json 03:16:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.crashreporter-symbols.zip 03:16:29 INFO - Running post-action listener: _resource_record_post_action 03:16:29 INFO - [mozharness: 2017-02-09 11:16:29.216786Z] Finished read-buildbot-config step (success) 03:16:29 INFO - [mozharness: 2017-02-09 11:16:29.217004Z] Running download-and-extract step. 03:16:29 INFO - Running pre-action listener: _resource_record_pre_action 03:16:29 INFO - Running main action method: download_and_extract 03:16:29 INFO - mkdir: /builds/slave/test/build/tests 03:16:29 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')]} 03:16:29 INFO - trying https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.test_packages.json 03:16:29 INFO - Downloading https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:16:29 INFO - Downloaded 896 bytes. 03:16:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:16:29 INFO - Using the following test package requirements: 03:16:29 INFO - {u'common': [u'target.common.tests.zip'], 03:16:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:16:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:16:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:16:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:16:29 INFO - u'mozbase': [u'target.common.tests.zip'], 03:16:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:16:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:16:29 INFO - u'web-platform': [u'target.common.tests.zip', 03:16:29 INFO - u'target.web-platform.tests.zip'], 03:16:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:16:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:16:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.common.tests.zip 03:16:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:16:29 INFO - Fetch https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.common.tests.zip into memory 03:16:30 INFO - Expected file size: 21858781 03:16:30 INFO - Obtained file size: 21858781 03:16:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:16:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.common.tests.zip 03:16:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:16:34 INFO - Fetch https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.common.tests.zip into memory 03:16:35 INFO - Expected file size: 21858781 03:16:35 INFO - Obtained file size: 21858781 03:16:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.talos.tests.zip 03:16:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:16:39 INFO - Fetch https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.talos.tests.zip into memory 03:16:40 INFO - Expected file size: 14403485 03:16:40 INFO - Obtained file size: 14403485 03:16:40 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')]} 03:16:40 INFO - trying https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.tar.bz2 03:16:40 INFO - Downloading https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:16:42 INFO - Downloaded 66136855 bytes. 03:16:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.tar.bz2 03:16:42 INFO - mkdir: /builds/slave/test/properties 03:16:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:16:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:16:42 INFO - Contents: 03:16:42 INFO - build_url:https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.tar.bz2 03:16:42 INFO - Running post-action listener: _resource_record_post_action 03:16:42 INFO - Running post-action listener: set_extra_try_arguments 03:16:42 INFO - [mozharness: 2017-02-09 11:16:42.138790Z] Finished download-and-extract step (success) 03:16:42 INFO - [mozharness: 2017-02-09 11:16:42.138886Z] Running populate-webroot step. 03:16:42 INFO - Running pre-action listener: _resource_record_pre_action 03:16:42 INFO - Running main action method: populate_webroot 03:16:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:16:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:16:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:16:42 INFO - '--tppagecycles', 03:16:42 INFO - '7'], 03:16:42 INFO - 'tests': ['tsvgm']}}, 03:16:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:16:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:16:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:16:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:16:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:16:42 INFO - 'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:16:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:16:42 INFO - 'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['damp', 'tps']}, 03:16:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:16:42 INFO - 'tests': ['damp', 'tps']}, 03:16:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['dromaeo_dom']}, 03:16:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:16:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['basic_compositor_video']}, 03:16:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:16:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['a11yr', 03:16:42 INFO - 'ts_paint', 03:16:42 INFO - 'tpaint', 03:16:42 INFO - 'sessionrestore', 03:16:42 INFO - 'sessionrestore_no_auto_restore', 03:16:42 INFO - 'tabpaint']}, 03:16:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:16:42 INFO - 'ts_paint', 03:16:42 INFO - 'tpaint', 03:16:42 INFO - 'sessionrestore', 03:16:42 INFO - 'sessionrestore_no_auto_restore', 03:16:42 INFO - 'tabpaint']}, 03:16:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:16:42 INFO - 'ts_paint', 03:16:42 INFO - 'tpaint', 03:16:42 INFO - 'sessionrestore', 03:16:42 INFO - 'sessionrestore_no_auto_restore', 03:16:42 INFO - 'tabpaint']}, 03:16:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:16:42 INFO - 'ts_paint', 03:16:42 INFO - 'tpaint', 03:16:42 INFO - 'sessionrestore', 03:16:42 INFO - 'sessionrestore_no_auto_restore', 03:16:42 INFO - 'tabpaint']}, 03:16:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['a11yr', 03:16:42 INFO - 'ts_paint', 03:16:42 INFO - 'tpaint', 03:16:42 INFO - 'sessionrestore', 03:16:42 INFO - 'sessionrestore_no_auto_restore', 03:16:42 INFO - 'tabpaint']}, 03:16:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['a11yr', 03:16:42 INFO - 'ts_paint', 03:16:42 INFO - 'tpaint', 03:16:42 INFO - 'sessionrestore', 03:16:42 INFO - 'sessionrestore_no_auto_restore', 03:16:42 INFO - 'tabpaint']}, 03:16:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['tsvgx', 03:16:42 INFO - 'tsvgr_opacity', 03:16:42 INFO - 'tart', 03:16:42 INFO - 'tscrollx', 03:16:42 INFO - 'cart', 03:16:42 INFO - 'tsvg_static']}, 03:16:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:16:42 INFO - 'tsvgr_opacity', 03:16:42 INFO - 'tart', 03:16:42 INFO - 'tscrollx', 03:16:42 INFO - 'cart', 03:16:42 INFO - 'tsvg_static']}, 03:16:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:16:42 INFO - 'talos_options': ['--disable-e10s'], 03:16:42 INFO - 'tests': ['tp5o']}, 03:16:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:16:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:16:42 INFO - 'talos_options': ['--disable-e10s', 03:16:42 INFO - '--xperf_path', 03:16:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:42 INFO - 'tests': ['tp5n']}, 03:16:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:16:42 INFO - 'talos_options': ['--xperf_path', 03:16:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:42 INFO - 'tests': ['tp5n']}}, 03:16:42 INFO - 'talos.zip': {'path': '', 03:16:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:16:42 INFO - Running post-action listener: _resource_record_post_action 03:16:42 INFO - [mozharness: 2017-02-09 11:16:42.151989Z] Finished populate-webroot step (success) 03:16:42 INFO - [mozharness: 2017-02-09 11:16:42.152079Z] Running create-virtualenv step. 03:16:42 INFO - Running pre-action listener: _resource_record_pre_action 03:16:42 INFO - Running main action method: create_virtualenv 03:16:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:16:42 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 03:16:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:16:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:16:42 INFO - Using real prefix '/usr' 03:16:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:16:42 INFO - Installing distribute.............................................................................................................................................................................................done. 03:16:44 INFO - Installing pip.................done. 03:16:44 INFO - Return code: 0 03:16:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:16:44 INFO - Reading from file tmpfile_stdout 03:16:44 INFO - Output received: 03:16:44 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) 03:16:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:16:44 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')]} 03:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:44 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')]} 03:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:44 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 0x1a111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d83980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', '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 03:16:44 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 03:16:44 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 03:16:44 INFO - Using env: {'DISPLAY': ':0', 03:16:44 INFO - 'HOME': '/home/cltbld', 03:16:44 INFO - 'LANG': 'en_US.UTF-8', 03:16:44 INFO - 'LANGUAGE': 'en_US:en', 03:16:44 INFO - 'LOGNAME': 'cltbld', 03:16:44 INFO - 'MAIL': '/var/mail/cltbld', 03:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:44 INFO - 'MOZ_NO_REMOTE': '1', 03:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:44 INFO - 'NO_EM_RESTART': '1', 03:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:44 INFO - 'PWD': '/builds/slave/test', 03:16:44 INFO - 'SHELL': '/bin/bash', 03:16:44 INFO - 'SHLVL': '1', 03:16:44 INFO - 'TERM': 'linux', 03:16:44 INFO - 'TMOUT': '86400', 03:16:44 INFO - 'USER': 'cltbld', 03:16:44 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:44 INFO - '_': '/tools/buildbot/bin/python'} 03:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:45 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 03:16:45 INFO - Cleaning up... 03:16:45 INFO - Return code: 0 03:16:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:16: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')]} 03:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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', '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 0x1a111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d83980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', '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 03:16: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:16: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 psutil>=3.1.1 03:16:45 INFO - Using env: {'DISPLAY': ':0', 03:16:45 INFO - 'HOME': '/home/cltbld', 03:16:45 INFO - 'LANG': 'en_US.UTF-8', 03:16:45 INFO - 'LANGUAGE': 'en_US:en', 03:16:45 INFO - 'LOGNAME': 'cltbld', 03:16:45 INFO - 'MAIL': '/var/mail/cltbld', 03:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:45 INFO - 'MOZ_NO_REMOTE': '1', 03:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:45 INFO - 'NO_EM_RESTART': '1', 03:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:45 INFO - 'PWD': '/builds/slave/test', 03:16:45 INFO - 'SHELL': '/bin/bash', 03:16:45 INFO - 'SHLVL': '1', 03:16:45 INFO - 'TERM': 'linux', 03:16:45 INFO - 'TMOUT': '86400', 03:16:45 INFO - 'USER': 'cltbld', 03:16:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:45 INFO - '_': '/tools/buildbot/bin/python'} 03:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:45 INFO - Downloading/unpacking psutil>=3.1.1 03:16:45 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 03:16:45 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 03:16:45 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 03:16:45 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 03:16:45 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 03:16:45 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 03:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:16:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:47 INFO - Installing collected packages: psutil 03:16:47 INFO - Running setup.py install for psutil 03:16:47 INFO - building 'psutil._psutil_linux' extension 03:16:47 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 03:16:47 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 03:16:47 INFO - building 'psutil._psutil_posix' extension 03:16:47 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 03:16:47 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 03:16:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:47 INFO - Successfully installed psutil 03:16:47 INFO - Cleaning up... 03:16:48 INFO - Return code: 0 03:16:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:16:48 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')]} 03:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:48 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')]} 03:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:48 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 0x1a111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d83980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', '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 03:16:48 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 03:16:48 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 03:16:48 INFO - Using env: {'DISPLAY': ':0', 03:16:48 INFO - 'HOME': '/home/cltbld', 03:16:48 INFO - 'LANG': 'en_US.UTF-8', 03:16:48 INFO - 'LANGUAGE': 'en_US:en', 03:16:48 INFO - 'LOGNAME': 'cltbld', 03:16:48 INFO - 'MAIL': '/var/mail/cltbld', 03:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:48 INFO - 'MOZ_NO_REMOTE': '1', 03:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:48 INFO - 'NO_EM_RESTART': '1', 03:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:48 INFO - 'PWD': '/builds/slave/test', 03:16:48 INFO - 'SHELL': '/bin/bash', 03:16:48 INFO - 'SHLVL': '1', 03:16:48 INFO - 'TERM': 'linux', 03:16:48 INFO - 'TMOUT': '86400', 03:16:48 INFO - 'USER': 'cltbld', 03:16:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:48 INFO - '_': '/tools/buildbot/bin/python'} 03:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:48 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 03:16:48 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 03:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:16:50 INFO - Installing collected packages: mozsystemmonitor 03:16:50 INFO - Running setup.py install for mozsystemmonitor 03:16:50 INFO - Successfully installed mozsystemmonitor 03:16:50 INFO - Cleaning up... 03:16:50 INFO - Return code: 0 03:16:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:16:50 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')]} 03:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:50 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')]} 03:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1a111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d83980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', '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 03:16:50 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 03:16:50 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 03:16:50 INFO - Using env: {'DISPLAY': ':0', 03:16:50 INFO - 'HOME': '/home/cltbld', 03:16:50 INFO - 'LANG': 'en_US.UTF-8', 03:16:50 INFO - 'LANGUAGE': 'en_US:en', 03:16:50 INFO - 'LOGNAME': 'cltbld', 03:16:50 INFO - 'MAIL': '/var/mail/cltbld', 03:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:50 INFO - 'MOZ_NO_REMOTE': '1', 03:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:50 INFO - 'NO_EM_RESTART': '1', 03:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:50 INFO - 'PWD': '/builds/slave/test', 03:16:50 INFO - 'SHELL': '/bin/bash', 03:16:50 INFO - 'SHLVL': '1', 03:16:50 INFO - 'TERM': 'linux', 03:16:50 INFO - 'TMOUT': '86400', 03:16:50 INFO - 'USER': 'cltbld', 03:16:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:50 INFO - '_': '/tools/buildbot/bin/python'} 03:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:50 INFO - Downloading/unpacking jsonschema==2.5.1 03:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:50 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 03:16:50 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 03:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:52 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 03:16:52 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 03:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:52 INFO - warning: no files found matching '*.txt' 03:16:52 INFO - no previously-included directories found matching 'build' 03:16:52 INFO - no previously-included directories found matching 'dist' 03:16:52 INFO - no previously-included directories found matching '.git*' 03:16:52 INFO - Installing collected packages: jsonschema, functools32 03:16:52 INFO - Running setup.py install for functools32 03:16:53 INFO - warning: no files found matching '*.txt' 03:16:53 INFO - no previously-included directories found matching 'build' 03:16:53 INFO - no previously-included directories found matching 'dist' 03:16:53 INFO - no previously-included directories found matching '.git*' 03:16:53 INFO - Successfully installed jsonschema functools32 03:16:53 INFO - Cleaning up... 03:16:53 INFO - Return code: 0 03:16:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:16:53 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')]} 03:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:53 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')]} 03:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1a111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d83980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', '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 03:16:53 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 03:16:53 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 03:16:53 INFO - Using env: {'DISPLAY': ':0', 03:16:53 INFO - 'HOME': '/home/cltbld', 03:16:53 INFO - 'LANG': 'en_US.UTF-8', 03:16:53 INFO - 'LANGUAGE': 'en_US:en', 03:16:53 INFO - 'LOGNAME': 'cltbld', 03:16:53 INFO - 'MAIL': '/var/mail/cltbld', 03:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:53 INFO - 'MOZ_NO_REMOTE': '1', 03:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:53 INFO - 'NO_EM_RESTART': '1', 03:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:53 INFO - 'PWD': '/builds/slave/test', 03:16:53 INFO - 'SHELL': '/bin/bash', 03:16:53 INFO - 'SHLVL': '1', 03:16:53 INFO - 'TERM': 'linux', 03:16:53 INFO - 'TMOUT': '86400', 03:16:53 INFO - 'USER': 'cltbld', 03:16:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:53 INFO - '_': '/tools/buildbot/bin/python'} 03:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:16:53 INFO - Cleaning up... 03:16:53 INFO - Return code: 0 03:16:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:16:53 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')]} 03:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:53 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')]} 03:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1a111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d83980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', '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 03:16:53 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 03:16:53 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 03:16:53 INFO - Using env: {'DISPLAY': ':0', 03:16:53 INFO - 'HOME': '/home/cltbld', 03:16:53 INFO - 'LANG': 'en_US.UTF-8', 03:16:53 INFO - 'LANGUAGE': 'en_US:en', 03:16:53 INFO - 'LOGNAME': 'cltbld', 03:16:53 INFO - 'MAIL': '/var/mail/cltbld', 03:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:53 INFO - 'MOZ_NO_REMOTE': '1', 03:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:53 INFO - 'NO_EM_RESTART': '1', 03:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:53 INFO - 'PWD': '/builds/slave/test', 03:16:53 INFO - 'SHELL': '/bin/bash', 03:16:53 INFO - 'SHLVL': '1', 03:16:53 INFO - 'TERM': 'linux', 03:16:53 INFO - 'TMOUT': '86400', 03:16:53 INFO - 'USER': 'cltbld', 03:16:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:53 INFO - '_': '/tools/buildbot/bin/python'} 03:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:53 INFO - Downloading/unpacking blobuploader==1.2.4 03:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:53 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 03:16:53 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 03:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:55 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 03:16:55 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 03:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:56 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 03:16:56 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 03:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:56 INFO - Downloading docopt-0.6.1.tar.gz 03:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:56 INFO - Running setup.py install for blobuploader 03:16:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:56 INFO - Running setup.py install for requests 03:16:56 INFO - Running setup.py install for docopt 03:16:56 INFO - Successfully installed blobuploader requests docopt 03:16:56 INFO - Cleaning up... 03:16:56 INFO - Return code: 0 03:16:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:56 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')]} 03:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:56 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')]} 03:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:56 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 0x1a111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d83980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', '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 03:16:56 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 03:16:56 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 03:16:57 INFO - Using env: {'DISPLAY': ':0', 03:16:57 INFO - 'HOME': '/home/cltbld', 03:16:57 INFO - 'LANG': 'en_US.UTF-8', 03:16:57 INFO - 'LANGUAGE': 'en_US:en', 03:16:57 INFO - 'LOGNAME': 'cltbld', 03:16:57 INFO - 'MAIL': '/var/mail/cltbld', 03:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:57 INFO - 'MOZ_NO_REMOTE': '1', 03:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:57 INFO - 'NO_EM_RESTART': '1', 03:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:57 INFO - 'PWD': '/builds/slave/test', 03:16:57 INFO - 'SHELL': '/bin/bash', 03:16:57 INFO - 'SHLVL': '1', 03:16:57 INFO - 'TERM': 'linux', 03:16:57 INFO - 'TMOUT': '86400', 03:16:57 INFO - 'USER': 'cltbld', 03:16:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:57 INFO - '_': '/tools/buildbot/bin/python'} 03:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:57 INFO - Running setup.py (path:/tmp/pip-sT4OVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:57 INFO - Running setup.py (path:/tmp/pip-5KXfPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:57 INFO - Running setup.py (path:/tmp/pip-n072TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:57 INFO - Running setup.py (path:/tmp/pip-WPE6uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:57 INFO - Running setup.py (path:/tmp/pip-JsT26H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:57 INFO - Running setup.py (path:/tmp/pip-T7GGGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:57 INFO - Running setup.py (path:/tmp/pip-UOQBkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:57 INFO - Running setup.py (path:/tmp/pip-QLHGo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:57 INFO - Running setup.py (path:/tmp/pip-9YRyYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:57 INFO - Running setup.py (path:/tmp/pip-FxhYM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:57 INFO - Running setup.py (path:/tmp/pip-ViHlyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:58 INFO - Running setup.py (path:/tmp/pip-17WP86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:58 INFO - Running setup.py (path:/tmp/pip-KQg8me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:58 INFO - Running setup.py (path:/tmp/pip-r2ZZVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:58 INFO - Running setup.py (path:/tmp/pip-_ahwvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:58 INFO - Running setup.py (path:/tmp/pip-2QjTsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:58 INFO - Running setup.py (path:/tmp/pip-QqbZPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:58 INFO - Running setup.py install for manifestparser 03:16:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:58 INFO - Running setup.py install for mozcrash 03:16:58 INFO - Running setup.py install for mozdebug 03:16:58 INFO - Running setup.py install for mozdevice 03:16:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:58 INFO - Running setup.py install for mozfile 03:16:58 INFO - Running setup.py install for mozhttpd 03:16:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Running setup.py install for mozinfo 03:16:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Running setup.py install for mozInstall 03:16:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Running setup.py install for mozleak 03:16:59 INFO - Running setup.py install for mozlog 03:16:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Running setup.py install for moznetwork 03:16:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Running setup.py install for mozprocess 03:16:59 INFO - Running setup.py install for mozprofile 03:16:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Running setup.py install for mozrunner 03:16:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:59 INFO - Running setup.py install for mozscreenshot 03:17:00 INFO - Running setup.py install for moztest 03:17:00 INFO - Running setup.py install for mozversion 03:17:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:17:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:17:00 INFO - Cleaning up... 03:17:00 INFO - Return code: 0 03:17:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:00 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')]} 03:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:00 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')]} 03:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:00 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 0x1a111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d83980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', '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 03:17:00 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 03:17:00 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 03:17:00 INFO - Using env: {'DISPLAY': ':0', 03:17:00 INFO - 'HOME': '/home/cltbld', 03:17:00 INFO - 'LANG': 'en_US.UTF-8', 03:17:00 INFO - 'LANGUAGE': 'en_US:en', 03:17:00 INFO - 'LOGNAME': 'cltbld', 03:17:00 INFO - 'MAIL': '/var/mail/cltbld', 03:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:00 INFO - 'MOZ_NO_REMOTE': '1', 03:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:00 INFO - 'NO_EM_RESTART': '1', 03:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:00 INFO - 'PWD': '/builds/slave/test', 03:17:00 INFO - 'SHELL': '/bin/bash', 03:17:00 INFO - 'SHLVL': '1', 03:17:00 INFO - 'TERM': 'linux', 03:17:00 INFO - 'TMOUT': '86400', 03:17:00 INFO - 'USER': 'cltbld', 03:17:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:00 INFO - '_': '/tools/buildbot/bin/python'} 03:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:00 INFO - Running setup.py (path:/tmp/pip-HXoteI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:00 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)) 03:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:00 INFO - Running setup.py (path:/tmp/pip-TIKu2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:00 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)) 03:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:00 INFO - Running setup.py (path:/tmp/pip-BPwDew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:00 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)) 03:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:00 INFO - Running setup.py (path:/tmp/pip-rIDyfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:00 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)) 03:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:00 INFO - Running setup.py (path:/tmp/pip-JtEAmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:00 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)) 03:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:00 INFO - Running setup.py (path:/tmp/pip-wMpgcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:00 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)) 03:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:00 INFO - Running setup.py (path:/tmp/pip-82Z1dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:00 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)) 03:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:00 INFO - Running setup.py (path:/tmp/pip-MCwO23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:01 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)) 03:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:01 INFO - Running setup.py (path:/tmp/pip-TPTNau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:01 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)) 03:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:01 INFO - Running setup.py (path:/tmp/pip-TOeN3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:01 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)) 03:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:01 INFO - Running setup.py (path:/tmp/pip-rlvzdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:01 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)) 03:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:01 INFO - Running setup.py (path:/tmp/pip-xKRRVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 03:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:01 INFO - Running setup.py (path:/tmp/pip-vjRkab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:01 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)) 03:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:01 INFO - Running setup.py (path:/tmp/pip-RP2EmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:01 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)) 03:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:01 INFO - Running setup.py (path:/tmp/pip-E33DIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:01 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)) 03:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:01 INFO - Running setup.py (path:/tmp/pip-PL79Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:01 INFO - Running setup.py (path:/tmp/pip-NpfySR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:01 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)) 03:17:01 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)) 03:17:01 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)) 03:17:01 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)) 03:17:01 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)) 03:17:01 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)) 03:17:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:17:01 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 03:17:01 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 03:17:01 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 03:17:01 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 03:17:01 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 03:17:01 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 03:17:03 INFO - Downloading blessings-1.6.tar.gz 03:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:17:03 INFO - Installing collected packages: blessings 03:17:03 INFO - Running setup.py install for blessings 03:17:03 INFO - Successfully installed blessings 03:17:03 INFO - Cleaning up... 03:17:03 INFO - Return code: 0 03:17:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:04 INFO - Reading from file tmpfile_stdout 03:17:04 INFO - Current package versions: 03:17:04 INFO - argparse == 1.2.1 03:17:04 INFO - blessings == 1.6 03:17:04 INFO - blobuploader == 1.2.4 03:17:04 INFO - docopt == 0.6.1 03:17:04 INFO - functools32 == 3.2.3-2 03:17:04 INFO - jsonschema == 2.5.1 03:17:04 INFO - manifestparser == 1.1 03:17:04 INFO - mozInstall == 1.12 03:17:04 INFO - mozcrash == 1.0 03:17:04 INFO - mozdebug == 0.1 03:17:04 INFO - mozdevice == 0.49 03:17:04 INFO - mozfile == 1.2 03:17:04 INFO - mozhttpd == 0.7 03:17:04 INFO - mozinfo == 0.9 03:17:04 INFO - mozleak == 0.1 03:17:04 INFO - mozlog == 3.4 03:17:04 INFO - moznetwork == 0.27 03:17:04 INFO - mozprocess == 0.24 03:17:04 INFO - mozprofile == 0.28 03:17:04 INFO - mozrunner == 6.13 03:17:04 INFO - mozscreenshot == 0.1 03:17:04 INFO - mozsystemmonitor == 0.3 03:17:04 INFO - moztest == 0.8 03:17:04 INFO - mozversion == 1.4 03:17:04 INFO - psutil == 3.1.1 03:17:04 INFO - requests == 1.2.3 03:17:04 INFO - wsgiref == 0.1.2 03:17:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:04 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')]} 03:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:04 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')]} 03:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1a111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d83980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', '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 03:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 03:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 03:17:04 INFO - Using env: {'DISPLAY': ':0', 03:17:04 INFO - 'HOME': '/home/cltbld', 03:17:04 INFO - 'LANG': 'en_US.UTF-8', 03:17:04 INFO - 'LANGUAGE': 'en_US:en', 03:17:04 INFO - 'LOGNAME': 'cltbld', 03:17:04 INFO - 'MAIL': '/var/mail/cltbld', 03:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:04 INFO - 'MOZ_NO_REMOTE': '1', 03:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:04 INFO - 'NO_EM_RESTART': '1', 03:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:04 INFO - 'PWD': '/builds/slave/test', 03:17:04 INFO - 'SHELL': '/bin/bash', 03:17:04 INFO - 'SHLVL': '1', 03:17:04 INFO - 'TERM': 'linux', 03:17:04 INFO - 'TMOUT': '86400', 03:17:04 INFO - 'USER': 'cltbld', 03:17:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:04 INFO - '_': '/tools/buildbot/bin/python'} 03:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:17:04 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)) 03:17:04 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)) 03:17:04 INFO - Cleaning up... 03:17:04 INFO - Return code: 0 03:17:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:17:04 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')]} 03:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:04 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')]} 03:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:04 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 0x1a111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d83980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', '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 03:17:04 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 03:17:04 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 03:17:04 INFO - Using env: {'DISPLAY': ':0', 03:17:04 INFO - 'HOME': '/home/cltbld', 03:17:04 INFO - 'LANG': 'en_US.UTF-8', 03:17:04 INFO - 'LANGUAGE': 'en_US:en', 03:17:04 INFO - 'LOGNAME': 'cltbld', 03:17:04 INFO - 'MAIL': '/var/mail/cltbld', 03:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:04 INFO - 'MOZ_NO_REMOTE': '1', 03:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:04 INFO - 'NO_EM_RESTART': '1', 03:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:04 INFO - 'PWD': '/builds/slave/test', 03:17:04 INFO - 'SHELL': '/bin/bash', 03:17:04 INFO - 'SHLVL': '1', 03:17:04 INFO - 'TERM': 'linux', 03:17:04 INFO - 'TMOUT': '86400', 03:17:04 INFO - 'USER': 'cltbld', 03:17:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:04 INFO - '_': '/tools/buildbot/bin/python'} 03:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:17:04 INFO - Cleaning up... 03:17:04 INFO - Return code: 0 03:17:04 INFO - Running post-action listener: _resource_record_post_action 03:17:04 INFO - Running post-action listener: _start_resource_monitoring 03:17:04 INFO - Starting resource monitoring. 03:17:04 INFO - [mozharness: 2017-02-09 11:17:04.688331Z] Finished create-virtualenv step (success) 03:17:04 INFO - [mozharness: 2017-02-09 11:17:04.688855Z] Running install step. 03:17:04 INFO - Running pre-action listener: _resource_record_pre_action 03:17:04 INFO - Running main action method: install 03:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:04 INFO - Reading from file tmpfile_stdout 03:17:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:17:04 INFO - Reading from file tmpfile_stdout 03:17:04 INFO - Output received: 03:17:04 INFO - Usage: mozinstall [options] installer 03:17:04 INFO - Options: 03:17:04 INFO - -h, --help show this help message and exit 03:17:04 INFO - -d DEST, --destination=DEST 03:17:04 INFO - Directory to install application into. [default: 03:17:04 INFO - "/builds/slave/test"] 03:17:04 INFO - --app=APP Application being installed. [default: firefox] 03:17:04 INFO - mkdir: /builds/slave/test/build/application 03:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:17:21 INFO - Reading from file tmpfile_stdout 03:17:21 INFO - Output received: 03:17:21 INFO - /builds/slave/test/build/application/firefox/firefox 03:17:21 INFO - Running post-action listener: _resource_record_post_action 03:17:21 INFO - [mozharness: 2017-02-09 11:17:21.439563Z] Finished install step (success) 03:17:21 INFO - [mozharness: 2017-02-09 11:17:21.439835Z] Running run-tests step. 03:17:21 INFO - Running pre-action listener: _resource_record_pre_action 03:17:21 INFO - Running main action method: run_tests 03:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:17:21 INFO - Python 2.7.3 03:17:21 INFO - Return code: 0 03:17:21 INFO - grabbing minidump binary from tooltool 03:17:21 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')]} 03:17:21 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 0x1d80d00>, '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 0x1d81a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d81eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:17:21 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 03:17:21 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 03:17:21 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 03:17:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:21 INFO - Return code: 0 03:17:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:17:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:17:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:17:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:17:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 03:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 03:17:21 INFO - Using env: {'DISPLAY': ':0', 03:17:21 INFO - 'HOME': '/home/cltbld', 03:17:21 INFO - 'LANG': 'en_US.UTF-8', 03:17:21 INFO - 'LANGUAGE': 'en_US:en', 03:17:21 INFO - 'LOGNAME': 'cltbld', 03:17:21 INFO - 'MAIL': '/var/mail/cltbld', 03:17:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:17:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:21 INFO - 'MOZ_NO_REMOTE': '1', 03:17:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:21 INFO - 'NO_EM_RESTART': '1', 03:17:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:21 INFO - 'PWD': '/builds/slave/test', 03:17:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:17:21 INFO - 'SHELL': '/bin/bash', 03:17:21 INFO - 'SHLVL': '1', 03:17:21 INFO - 'TERM': 'linux', 03:17:21 INFO - 'TMOUT': '86400', 03:17:21 INFO - 'USER': 'cltbld', 03:17:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908', 03:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:21 INFO - '_': '/tools/buildbot/bin/python'} 03:17:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 03:17:21 INFO - mozversion application_buildid: 20170209101614 03:17:21 INFO - mozversion application_changeset: 7bab8cf2a1cf936aeeceb61d8f791ff8f4e9223b 03:17:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:17:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:21 INFO - mozversion application_name: Firefox 03:17:21 INFO - mozversion application_remotingname: firefox-dev 03:17:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:21 INFO - mozversion application_vendor: Mozilla 03:17:21 INFO - mozversion application_version: 53.0a2 03:17:21 INFO - mozversion platform_buildid: 20170209101614 03:17:21 INFO - mozversion platform_changeset: 7bab8cf2a1cf936aeeceb61d8f791ff8f4e9223b 03:17:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:21 INFO - mozversion platform_version: 53.0a2 03:17:21 INFO - using testdate: 1486639041 03:17:21 INFO - actual date: 1486639041 03:17:21 INFO - starting webserver on 'localhost:39588' 03:17:21 INFO - SUITE-START | Running 2 tests 03:17:21 INFO - TEST-START | dromaeo_css 03:17:21 INFO - operating with platform_type : linux_ 03:17:21 INFO - Initialising browser for dromaeo_css test... 03:17:21 INFO - TEST-INFO | started process 10051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQp4yWo/profile http://localhost:39588/getInfo.html) 03:17:25 INFO - PROCESS | 10051 | __metrics Screen width/height:1600/1200 03:17:25 INFO - PROCESS | 10051 | colorDepth:24 03:17:25 INFO - PROCESS | 10051 | Browser inner width/height: 1024/697 03:17:25 INFO - PROCESS | 10051 | __metrics 03:17:26 INFO - PROCESS | 10051 | 1486639046035 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 03:17:26 INFO - PROCESS | 10051 | 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" 03:17:26 INFO - PROCESS | 10051 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:17:27 INFO - TEST-INFO | 10051: exit 0 03:17:27 INFO - Browser initialized. 03:17:27 INFO - Running cycle 1/1 for dromaeo_css test... 03:17:27 INFO - TEST-INFO | started process 10141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQp4yWo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:38 INFO - PROCESS | 10141 | RSS: Main: 137953280 03:17:38 INFO - PROCESS | 10141 | 03:20:38 INFO - PROCESS | 10141 | Cycle 1(1): loaded http://localhost:39588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39588/tests/dromaeo/cssquery-ext.html) 03:20:40 INFO - PROCESS | 10141 | RSS: Main: 241881088 03:20:40 INFO - PROCESS | 10141 | 03:22:28 INFO - PROCESS | 10141 | ************************* 03:22:28 INFO - PROCESS | 10141 | A coding exception was thrown and uncaught in a Task. 03:22:28 INFO - PROCESS | 10141 | 03:22:28 ERROR - PROCESS | 10141 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:22:28 INFO - PROCESS | 10141 | Full stack: 03:22:28 INFO - PROCESS | 10141 | ************************* 03:23:42 INFO - PROCESS | 10141 | Cycle 1(1): loaded http://localhost:39588/tests/dromaeo/cssquery-ext.html (next: http://localhost:39588/tests/dromaeo/cssquery-jquery.html) 03:23:42 INFO - PROCESS | 10141 | RSS: Main: 227061760 03:23:42 INFO - PROCESS | 10141 | 03:26:44 INFO - PROCESS | 10141 | Cycle 1(1): loaded http://localhost:39588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39588/tests/dromaeo/cssquery-mootools.html) 03:26:45 INFO - PROCESS | 10141 | RSS: Main: 227143680 03:26:45 INFO - PROCESS | 10141 | 03:29:47 INFO - PROCESS | 10141 | Cycle 1(1): loaded http://localhost:39588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39588/tests/dromaeo/cssquery-prototype.html) 03:29:48 INFO - PROCESS | 10141 | RSS: Main: 214777856 03:29:48 INFO - PROCESS | 10141 | 03:32:50 INFO - PROCESS | 10141 | Cycle 1(1): loaded http://localhost:39588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39588/tests/dromaeo/cssquery-yui.html) 03:32:51 INFO - PROCESS | 10141 | RSS: Main: 170475520 03:32:51 INFO - PROCESS | 10141 | 03:35:53 INFO - PROCESS | 10141 | Cycle 1(1): loaded http://localhost:39588/tests/dromaeo/cssquery-yui.html (next: http://localhost:39588/tests/dromaeo/cssquery-dojo.html) 03:35:54 INFO - PROCESS | 10141 | RSS: Main: 265375744 03:35:54 INFO - PROCESS | 10141 | 03:35:54 INFO - PROCESS | 10141 | __start_tp_report 03:35:54 INFO - PROCESS | 10141 | _x_x_mozilla_page_load 03:35:54 INFO - PROCESS | 10141 | _x_x_mozilla_page_load_details 03:35:54 INFO - PROCESS | 10141 | |i|pagename|runs| 03:35:54 INFO - PROCESS | 10141 | |0;dojo.html;3170.239142605774;3192.0264319382577;3215.855286512107;3246.7727259091857;3257.3485302939403;5383.219433182187;5387.1111266641055;5411.107167317393;5415.783368665258;5468.070428027235;5443.2107344435035;5484.698341591211;5503.9174412383745;5565.582581306398;5588.497035266825;5070.695758254507;5091.083604951126;5110.948890511103;5167.3282473278605;5169.353830771153;4981.476944920767;5017.673851199678;5027.296178535008;5094.770735316901;5106.948930510703;4987.875303117415;5091.210862316347;5097.541221290083;5119.436861945183;5131.358580177478;5111.361079865017;5111.952049829776;5122.205017649913;5123.5901127909865;5152.201408781645;4805.543473370024;4825.372701548777;4968.552830245295;4985.351904252424;5056.595472362203;5420.430854760233;5473.698946557938;5490.039243132475;5536.557075433956;5575.0522411190195;5943.108533719934;5983.222181116427;5997.850053748648;5998.910016349758;6000.159977603139;5860.589758716891;5996.040633498619;6013.398660133952;6016.127661489103;6018.789342373039;5438.885028569134;5487.6158668893195;5489.176623506466;5556.749946252428;5594.776208951596;5989.921814073421;5995.160677505153;6000.519958403317;6005.249343832021;6020.909686354708;5744.827655170351;5807.0998995155815;5814.011618024946;5815.912761308584;5816.389279125716;5694.772209111589;5718.399568045295;5747.453991870766;5758.424157584208;5855.180274761537;5792.478676919098;5836.299644042742;5840.065589505659;5850.385709500526;5856.912146317809;5815.04051831443;5833.50415214703;5842.824715258549;5847.883042339215;5854.560907931922;4373.387725718402;4378.16814805186;4417.867463976086;4418.447694038246;4451.265541185668;4075.8505852821913;4077.938830917539;4087.2438598859308;4103.4460347853255;4113.670906327487;5751;5751.568632352591;5751.913721294184;5753.62601430914;5765.769369225268;5790.131480277992;5798.88402231953;5850.882982340329;5859.355470898197;5904.143899134688;5706.172604972256;5709.628874123252;5709.942900571024;5715.057015592464;5730.398308177581;5044.899102017939;5046.142155833517;5054.873628159326;5055.646104772631;5056.570191533688;5951.285845698458;6001.039833626686;6017.699115044143;6018.999999999913;6137.0794380842335;5913.763449461973;5915.6450612961635;5915.970420147872;5933.495652869555;5947.167396564571;6100.54245931548;6103.42017508336;6105.84735381619;6109.908351374644;6146.938530614637;5691.857703557279;5728.054870946247;5778.508826749773;5804.709764511842;5828.53371730269;5810.912836307374;5879.588428809942;5898;5930.881382372415;5992.640441573345;5820.621659592113;5827.854303642443;5829.09649004405;5831.446012628793;5832.504237139721;5758.856028599319;5813.534917206529;5816.41835816415;5822.359540450631;5824.621399609012;5623.156526520891;5673.574481913955;5706.514946229451;5740.885182296414;5747.885042299215;5822.417758224144;5824.825255242349;5836.474717275466;5838.824835254949;5869.53043756507;5704.172894930295;5709.0865461525955;5710.885782284248;5713.800016999385;5716.28546431696 03:35:54 INFO - PROCESS | 10141 | |1;ext.html;559.1175964821776;578.6123297390748;617.9710781548723;623.2365352443258;657.3196741372681;39584.99999999996;47011.76494117529;48569.51430485699;48609.756951215284;53461.73269133658;51608.74195629016;52040.47959520404;52188;52203.73898130504;52203.738981305134;9322.067793220675;9499.097585729345;9508.904910950905;9513.238940884712;9515.238780897545;8267.090620031791;8447.113053129426;10985.61550345738;11234.887651123467;11249.83125253122;11404.942975285112;11475.368854712988;11485.885141148607;11489.59786407476;11498.080153587734;11416.372099534523;11486.827697584544;11501;11507.712307192303;11511.654650360502;11263.43682815856;11315.3210807351;11316.547338106466;11319.547218111265;11321.377324247163;49080;49454.50545494535;49643.25535116976;49646.50353496455;49653.75173124147;4342.804573794187;4496.7301961882395;4537.636989040869;4556.134334476472;4732.952670473285;32452.83773581117;32581.348373032644;32620.836895815606;32851;33573.83213083944;4312.33158860374;4326.480822301312;4365.541618130114;4371.169477799208;4375.2124617568825;380649;382333;382518;382562;383721;60552;61561.07658385128;61599;61646.0753088704;61707.074393884126;63339.366606333344;63655.68172159109;63728;63745.68127159427;63756.36243637504;18959.052047397574;19605.31381401644;19626.803731962784;19628;19652.21391144367;13700.314984250748;14079.788803167961;15180.696386072217;15300.693986120215;15321.23393830304;19155.61688766217;19587.634018943616;20574.69137962932;20581.279655211994;20693.17227310921;7423.554586724814;7586;7596.025033491332;7691.461597688108;7816.726414575576;994.6021591363368;1025.2310766924807;1025.4923812712755;1043.7338478687886;1049.8530205771199;34297.31405371879;34593;34701.82649086738;34836.477452838226;35522.82238588791;1148.494662348564;1175.1715040896318;1197.634721409961;1225.8099994500867;1232.2975903734784;18386.81613183878;18451.16969736338;18637.534061648297;18722.719159212622;18767.155478003522;539796;545253;547878;548160;548701;69455;70441.64779176071;70499.2950070503;70545;70612.29387706057;1541.2756004677783;1573.622330640661;1592.633694250329;1597.3770229610461;1609.4045203274864;32538.34923301568;33641.495377569845;33711.66288337085;33775.723232925935;34088.318233635684;58093;58728;58802;58871;58882;378658;378747;379444;382838.68645254994;383521;27790;28475.006749527332;31335.21661958469;31825.5226171603;48263.27605085856;50904;51189.232161518354;55857;55983;57026;45027.549724502336;47559;47628.52371476241;47678;48933.51066489289;45483.31775023443;47779.28331074967;48041;48061.279080814515;49076.26385604147;46522.76738616285;46997.53002470068;48251.75874120607;48308.51691483181;48458.27312590244;39638.2072358557;41970.790146049076;42109;42198.78900605477;42409.36385954275;31196.220094497818;31552.368952621277;31576.789829678764;31844.68155318417;31914.52128218032 03:35:54 INFO - PROCESS | 10141 | |2;jquery.html;401.74087713424825;433.96962212645127;438.3512401645565;441.0417745211263;447.946246450426;18547;20931.686024709623;22083.6687449688;22490.325290241297;22645.77354226457;22498.43753906153;22687.773122268773;22785.658215126747;23011.539769204646;23130.884345578248;5347.54545863602;5995.52035837132;6207.162033125538;6816.931830681704;6871.931280687204;6773.559718618299;6815.148106486689;6972.686229119677;6973.093497845273;6981.301869813004;6838.6580670966505;6887.139107611549;6889.242183359826;6892.862142757167;6892.965535172317;6733.46132309414;6851.38337549618;6882.518223724316;6890.965545172267;6900.7929762107215;6109.297430795471;6123.6938153092615;6136.23297087864;6136.631802091844;6139.048447490646;25376;25440.872795635903;25454.36364090894;25481.87259063693;25915.22254332373;2800.845953472558;2956.7782416318864;2985.507391280436;3002.369502404498;3028.303490197245;11127.332360058423;11301.547938082467;11500.884991150066;11506.88493115075;11663.94168029163;2005.4886004069015;2049.1803278688494;2058.084152552115;2069.4412508622736;2098.370488853338;89548;98247.50876245573;98888;99370.50314748452;100267.9973200266;10411.583536658449;10972.670819875417;11574.363410012362;12154;12363.75272494545;16631.750523742154;17354.913225433793;17434.47696569105;18290;18393;9556.378835375679;9601.90398096024;9662.08210220028;9733.124018838338;9813;9205.585748641328;9284.95357523208;9369.484678342757;9421.24630029596;9559.187469065208;5440.972795135999;5490.231367608538;5501.642393244426;5512.6968016758665;5575.107982722745;2203.9559208816054;2244.450109723128;2266.9093236270696;2320.071971211495;2335.07764433048;928.2481190235931;939.2392162348519;943.6508491858057;946.5172761891484;958.4393130018877;19459.708104378446;21088.261910833047;21288.36134915955;21406;21489.355319340444;933.5005771911995;936.3585943628636;945.6406565505201;952.5713428956997;962.6775030364767;10996.560137594566;11544.94227528857;11658.417079146178;11740.471678774476;11797.35114568707;297787;401960;740282;747030;748955;107078;107214;108044;109727.45136274428;111888;1052.2055847834836;1101.5648818716722;1120.7590368070742;1124.4658787076073;1130.2992144870234;18043.368482103062;18254.634907302046;18346;18519.90740046291;18660.160292786586;45584.54415455803;46164;46235.306470403644;46693.53306466892;46853;63475;64229;64289;65058.67470662617;65067.349326506126;9470.100340467645;9669.613215471303;9702;9887.110160085627;9893.35693179941;12160;14226.430942762587;14354.354054067384;14456.060356076821;14496.492622758153;11757.412129393326;12206.267623942593;12216.938915305367;12235.877641223475;12485.56300529477;12136.514539418324;12153.331566763913;12225.510979560719;12612;12724.236545807282;12447;12481.93759031199;12589.43347549344;12665.366731663564;12694.555690551157;9498.905010949802;9719;9766.658166964122;9889.258305626963;9907.306488545733;11873.406329683308;11940.641780746591;12624.810627840407;12663.113582049167;12753.48986040585 03:35:54 INFO - PROCESS | 10141 | |3;mootools.html;1487;1493.7759336099584;1501.6996600679863;1515.439287463638;1518.5216656753119;8194.672213111477;8714.17215364541;8715.172058654425;8748.081451447602;8768.123187681229;7557.735479258227;7818.569978651172;8112.959435202816;8293;8307.750767476986;2369.786719195268;2405.903763849453;2406.3262286559793;2410.7227668818136;2414.61366181411;2399.7960173385195;2432.136591510015;2436.1717016214484;2451.080844683244;2451.203358908353;2365.1367250953363;2365.6924599802;2381.1903952656094;2389.486260454002;2391.2945681024053;2375.3824005758543;2376.6910301660846;2391.7847393734473;2399.5800734871327;2406.1217655555683;2317.8261630377788;2321.5356928614347;2383.487550176703;2387.152560840894;2394.114177754242;8639.39524233304;8705.085965973545;8705.390622656416;8709.95645021777;8715.825683486359;5262.2632831403635;5406.08096623575;5414.972925135349;5423.430539793344;5427.240186373911;3437.123533498967;3452.2577645806273;3496.1434448560267;3504.5794504659602;3518.736094792875;1383.969107654234;1404.9157050576998;1410.8024876517295;1441.5242969819935;1526.4962562354397;11193.72015699614;11335.603253886156;11471.369074700888;11873.228240164448;11903.22629029119;4509.098180363941;4682.297655351725;4718.598919091915;4757.643176761757;4759.6668233223345;9520.143187113194;9526.90473095274;9531.714048578553;9543.713688589354;9547.379420337656;5396.730163491809;5401.567874570025;5401.7029063401105;5403.5136837684795;5407.080796264644;4459.620932220732;4576.222042252758;4923.064617722621;4983.127952608279;4985.202367621163;3926.528816541976;4008.198360327946;4025.7785821780085;4075.7962101894786;4092.202020606013;1227.533537255855;1240.3054289597853;1245.7944439167618;1250.2995925541256;1258.2639156093605;1027.3733022856052;1056.7358160459885;1060.6870973062964;1063.6330465989377;1067.2742535076222;5728.48443640066;5808.30300363959;6072;6085.391460853968;6259.530535209878;652.1228947066188;655.9770408035696;659.7328082126746;663.6250518457057;672.5661948043485;4079.082206503513;4258.297380932111;4281.143771245764;4294.184105020036;4316.503602085738;10145.94927025375;10474;10479.738006549896;10482.37105773656;10489.265751397481;9803.803923921481;10117.544710488046;10208.846867296996;10310.484475776331;10419.687409377731;8124.512529248264;8292.419530632798;8300.667973281123;8309.501429914224;8346.374021948257;5727.7422515986045;5875.20684707559;5904.468597826216;5944.167816505606;6062.120992455981;9380.155785979294;9528.904710953078;9575.138237558653;9576.23390128774;9576.425414475154;9788.119069283799;9885.50572471388;9936.652217172365;9952.203823693942;9958.253131015057;6990.6504674767075;7164.211936687065;7431.739889103856;7490;7548;8283.710070147516;8445.915540844759;8449.746507604781;8455.492670439793;8462.788430289293;7297.16082650502;7359.411247100326;7399.667014984447;7427.740029098955;7430.108386993596;7445.664945077593;7460.4031677466755;7484.887726684213;7541.321281084729;7571.129320128035;6390.7443702251385;6457.61254324742;6458.257300410513;6471.870562588816;6479.125318081999;5000.849974500771;5066.316047333563;5069.239614057921;5083.771230294572;5213.504717051874;5147.485251474973;5190.273361729436;5192.5586325162785;5247.973760131327;5301.5493683037375 03:35:54 INFO - PROCESS | 10141 | |4;prototype.html;403.67302484987164;405.92287465381577;416.9312063509521;419.6495925901873;425.1730384402339;5246.685198888069;5347.652402593833;5374.355077390714;5420.810271640494;5429.375621803494;4867.902641947159;5245.134552798783;5252.185911183763;5279.366476022873;5279.894402111955;4291.4421125253675;4309.913801723971;4327.394164816928;4353.194658988082;4365.712114926105;4334.934975975347;4336.1978034063795;4345.174416860787;4361.34579813029;4362.389265502832;4352;4355.085432059255;4356.43366362374;4361.666508417997;4408.360787685784;4029.355303151496;4190.497140343148;4192.454980852485;4209.284421648296;4209.958170287408;3775.2449510097817;3776.527934008249;3781.621837816196;3794.918448242238;3797.715171362159;5254.710990895499;5258.421573626898;5263.31576895005;5278.630495865253;5287.524122828925;4649.302604609302;4816.7350795706225;4826.203676393391;4865.635077369211;4866.975665121652;5529.30883639545;5543.334799824047;5545.168224766277;5564.944350556483;5594.74118323378;4146.3365861462025;4147.875563733093;4158.795838205726;4162.271602469556;4164.271252530825;5513.421090785449;5724.971375143139;5726.599138060337;5764.394738552433;5779.855503612402;4187.685923555746;4192.601702838226;4203.285441474956;4205.17998990194;4221.134667393177;4245.80893859777;4289.571042895685;4295.334223195409;4301.763403012802;4319.9784001080425;4702.623790096853;4735.337052812609;4793.472718001017;4826.083044221657;4884.145274577006;5575.553955683536;5578.386377498472;5590.217369568264;5627.240322556484;5631.549476041907;1380.792881067848;1390.3048475762118;1393.512270705245;1411.710599327156;1414.2433797918065;960.5389413081759;1003.3628645809963;1012.8683271174848;1013.5793645636978;1022.1414012229762;5290.629655924048;5298.735063246822;5330.680159190461;5333.853221557384;5385.461453854661;5471.753771080311;5492.80775172867;5519.31008623922;5534.1975413565615;5535.972320138454;5042.243663450438;5249.763760630781;5266.2890509781455;5305.734713264322;5310.893782124336;2910.3160757222035;2917.7957542972213;2931.0327591894625;2948.557716342566;2967.4658561458714;5738.540916726652;5743.85640358986;5744.971275143681;5787.71061446926;5789.305283366023;5543.113101903757;5600.775968961278;5676.801311954062;5808;5830.271216097988;5760.107183386582;5906.316699740553;5910.4385083417865;5925.962956482685;5964.701764911824;5681.346645135863;5684.488396044376;5690.317161940594;5754.136879468113;5758.62568933018;5442.591805614516;5587.245721827664;5598.3282006159525;5604.299462567179;5610.326760788732;5898.233229680286;5926.7925622603;5943.821685349447;5966.671833049224;5993.4006599341465;4042.2521833460905;4221.683373747042;4233.364995250737;4247.405363249086;4260.808263628206;5716;5729.598928074995;5737.282839645044;5743.822516384048;5752.33848107473;5607.747651355618;5619.634723742944;5624.456592346795;5636.267285252891;5639.336395763342;5308.283381743569;5542.11326187808;5569.443055694398;5614.242077319673;5618.410066942912;5571.303587051619;5581.469760372758;5588.541041941533;5592.608517403743;5595.832125036255;5579.214651311704;5606.551475882001;5611.775528978795;5641;5650;5254.185601231662;5480.287562616834;5502.697351645698;5511.448855114457;5519.227308176939 03:35:54 INFO - PROCESS | 10141 | |5;yui.html;842;865.0916537635485;865.6710450028988;919.4988731141527;943.1747221181466;14938.77591836122;16881.746773798386;17573.824261757378;17937.64124717505;17939.73090403645;16276.75584866228;16502.25739841707;16577.088260145687;16649.33402663892;16689.749653755203;704.2499737779274;730.7332823519404;846.8264005878796;859.1537335724306;860.0410542245414;814.2590242878981;847.2925107535216;857.6140736668524;861.5692153923038;862.3446180902528;900.5632268349846;904.6200595749768;904.6878826804742;906.9138431848963;907.0340087806497;732.9010583571203;761.2996043639864;901.0313912544009;901.8106197698492;901.8647202919582;630.8265227062549;647.3041480408533;655.7278729327323;657.5068698476143;658.0852614865341;16600.584985375343;16921;16948.491545253662;16992.40526581576;17004.06477643729;14980.400783968627;15364.846351536453;15474.690506189812;15760.369585216578;15860.682786344209;14337.856621433757;14349.497767578085;14400.279986000764;14658.193799341032;14815.851841481555;4039.7576145431367;4649;4656.4645065817185;4741.905161896777;4808.350872632185;72720.63639681821;86540.56729716374;87024;88783.55608221982;90249;12414.193077449936;12584.685382865502;12643.747125057447;12697.301648409426;12875;23067.423314417272;23098.307050788502;23174.304770856903;23321.300360989197;23476.295711128692;8528.061913189544;8673.956630216935;8815.074417186232;8879.422837515542;9242.445453272825;4849.393825771778;5052.850459192499;5087.694738315713;5106.591472682177;5128.1282182029145;3591.317649646559;3699.3341198584512;3700.3339398907915;3702.3891057975134;3704.388775852008;622.1694038458709;631.8199313195718;636.9299377068519;639.9008153736179;641.7914177892204;846.4794151596724;846.9497822699808;877.7937184761576;887.2502735188755;889.3907673243849;11551.76896462083;11688.70778230551;11712;11992.520299187934;12139.575114870937;658.5916731626422;665.690453938911;689.1248114894056;719.9208087110413;851.6040041380787;5066.620003499752;5378.19327100938;5421.241026256327;5723.59934804568;5860.941390586125;66588;81217;82328.58835705783;82467.58766206131;83697.16302836893;70595.64702176559;70794;71472;72823;73133.2686673137;62850.685746571886;63243;63675.36324636694;63721;66193.00710489346;10727.141828653845;10793.669698819358;10798.352098874093;10953.83569246478;11031.889681103086;40872.386914196904;41492.79253603713;41610.58389416067;41872.3719144207;42340.576594233666;53717.73141134269;54430.72784636052;55168.724156378965;55429.44570554243;55550.444495554526;14097.718045639234;14138.78791818144;14139.787903181255;14874.181919994504;14875.628109297355;16474.325565234943;16780.58048548796;17101.57246068858;17126.657466850345;17315.307387704856;15344.846551534341;15654.452094177104;15905;16168.191590420667;16699.415520456725;14057.578272651837;14063.929680351534;14086.647833804236;14113.2943352834;14146.717065658835;14713.117212967256;14825.110493370432;15224.543263702106;15270.541883743506;15920.442784502487;10264.486775661038;10560.313579617301;10911.672649820519;11028.172887033345;11083.833742493707;11132.88867111351;12779.936100319439;12895.806562901376;13086.214827110403;13321.200727956353 03:35:54 INFO - PROCESS | 10141 | __end_tp_report 03:35:54 INFO - PROCESS | 10141 | __start_cc_report 03:35:54 INFO - PROCESS | 10141 | _x_x_mozilla_cycle_collect,930 03:35:54 INFO - PROCESS | 10141 | __end_cc_report 03:35:54 INFO - PROCESS | 10141 | __startTimestamp1486640154062__endTimestamp 03:35:54 INFO - PROCESS | 10141 | 03:35:54 INFO - PROCESS | 10141 | ------- Summary: start ------- 03:35:54 INFO - PROCESS | 10141 | Number of tests: 6 03:35:54 INFO - PROCESS | 10141 | 03:35:54 INFO - PROCESS | 10141 | [#0] dojo.html Cycles:165 Average:5489.02 Median:5740.89 stddev:615.62 (10.7%) stddev-sans-first:590.02 03:35:54 INFO - PROCESS | 10141 | Values: 3170.2 3192.0 3215.9 3246.8 3257.3 5383.2 5387.1 5411.1 5415.8 5468.1 5443.2 5484.7 5503.9 5565.6 5588.5 5070.7 5091.1 5110.9 5167.3 5169.4 4981.5 5017.7 5027.3 5094.8 5106.9 4987.9 5091.2 5097.5 5119.4 5131.4 5111.4 5112.0 5122.2 5123.6 5152.2 4805.5 4825.4 4968.6 4985.4 5056.6 5420.4 5473.7 5490.0 5536.6 5575.1 5943.1 5983.2 5997.9 5998.9 6000.2 5860.6 5996.0 6013.4 6016.1 6018.8 5438.9 5487.6 5489.2 5556.7 5594.8 5989.9 5995.2 6000.5 6005.2 6020.9 5744.8 5807.1 5814.0 5815.9 5816.4 5694.8 5718.4 5747.5 5758.4 5855.2 5792.5 5836.3 5840.1 5850.4 5856.9 5815.0 5833.5 5842.8 5847.9 5854.6 4373.4 4378.2 4417.9 4418.4 4451.3 4075.9 4077.9 4087.2 4103.4 4113.7 5751.0 5751.6 5751.9 5753.6 5765.8 5790.1 5798.9 5850.9 5859.4 5904.1 5706.2 5709.6 5709.9 5715.1 5730.4 5044.9 5046.1 5054.9 5055.6 5056.6 5951.3 6001.0 6017.7 6019.0 6137.1 5913.8 5915.6 5916.0 5933.5 5947.2 6100.5 6103.4 6105.8 6109.9 6146.9 5691.9 5728.1 5778.5 5804.7 5828.5 5810.9 5879.6 5898.0 5930.9 5992.6 5820.6 5827.9 5829.1 5831.4 5832.5 5758.9 5813.5 5816.4 5822.4 5824.6 5623.2 5673.6 5706.5 5740.9 5747.9 5822.4 5824.8 5836.5 5838.8 5869.5 5704.2 5709.1 5710.9 5713.8 5716.3 03:35:54 INFO - PROCESS | 10141 | 03:35:54 INFO - PROCESS | 10141 | [#1] ext.html Cycles:180 Average:62903.78 Median:42304.08 stddev:116928.76 (276.4%) stddev-sans-first:117163.08 03:35:54 INFO - PROCESS | 10141 | Values: 559.1 578.6 618.0 623.2 657.3 39585.0 47011.8 48569.5 48609.8 53461.7 51608.7 52040.5 52188.0 52203.7 52203.7 9322.1 9499.1 9508.9 9513.2 9515.2 8267.1 8447.1 10985.6 11234.9 11249.8 11404.9 11475.4 11485.9 11489.6 11498.1 11416.4 11486.8 11501.0 11507.7 11511.7 11263.4 11315.3 11316.5 11319.5 11321.4 49080.0 49454.5 49643.3 49646.5 49653.8 4342.8 4496.7 4537.6 4556.1 4733.0 32452.8 32581.3 32620.8 32851.0 33573.8 4312.3 4326.5 4365.5 4371.2 4375.2 380649.0 382333.0 382518.0 382562.0 383721.0 60552.0 61561.1 61599.0 61646.1 61707.1 63339.4 63655.7 63728.0 63745.7 63756.4 18959.1 19605.3 19626.8 19628.0 19652.2 13700.3 14079.8 15180.7 15300.7 15321.2 19155.6 19587.6 20574.7 20581.3 20693.2 7423.6 7586.0 7596.0 7691.5 7816.7 994.6 1025.2 1025.5 1043.7 1049.9 34297.3 34593.0 34701.8 34836.5 35522.8 1148.5 1175.2 1197.6 1225.8 1232.3 18386.8 18451.2 18637.5 18722.7 18767.2 539796.0 545253.0 547878.0 548160.0 548701.0 69455.0 70441.6 70499.3 70545.0 70612.3 1541.3 1573.6 1592.6 1597.4 1609.4 32538.3 33641.5 33711.7 33775.7 34088.3 58093.0 58728.0 58802.0 58871.0 58882.0 378658.0 378747.0 379444.0 382838.7 383521.0 27790.0 28475.0 31335.2 31825.5 48263.3 50904.0 51189.2 55857.0 55983.0 57026.0 45027.5 47559.0 47628.5 47678.0 48933.5 45483.3 47779.3 48041.0 48061.3 49076.3 46522.8 46997.5 48251.8 48308.5 48458.3 39638.2 41970.8 42109.0 42198.8 42409.4 31196.2 31552.4 31576.8 31844.7 31914.5 03:35:54 INFO - PROCESS | 10141 | 03:35:54 INFO - PROCESS | 10141 | [#2] jquery.html Cycles:180 Average:33785.16 Median:14358.03 stddev:102283.00 (712.4%) stddev-sans-first:102539.22 03:35:54 INFO - PROCESS | 10141 | Values: 401.7 434.0 438.4 441.0 447.9 18547.0 20931.7 22083.7 22490.3 22645.8 22498.4 22687.8 22785.7 23011.5 23130.9 5347.5 5995.5 6207.2 6816.9 6871.9 6773.6 6815.1 6972.7 6973.1 6981.3 6838.7 6887.1 6889.2 6892.9 6893.0 6733.5 6851.4 6882.5 6891.0 6900.8 6109.3 6123.7 6136.2 6136.6 6139.0 25376.0 25440.9 25454.4 25481.9 25915.2 2800.8 2956.8 2985.5 3002.4 3028.3 11127.3 11301.5 11500.9 11506.9 11663.9 2005.5 2049.2 2058.1 2069.4 2098.4 89548.0 98247.5 98888.0 99370.5 100268.0 10411.6 10972.7 11574.4 12154.0 12363.8 16631.8 17354.9 17434.5 18290.0 18393.0 9556.4 9601.9 9662.1 9733.1 9813.0 9205.6 9285.0 9369.5 9421.2 9559.2 5441.0 5490.2 5501.6 5512.7 5575.1 2204.0 2244.5 2266.9 2320.1 2335.1 928.2 939.2 943.7 946.5 958.4 19459.7 21088.3 21288.4 21406.0 21489.4 933.5 936.4 945.6 952.6 962.7 10996.6 11544.9 11658.4 11740.5 11797.4 297787.0 401960.0 740282.0 747030.0 748955.0 107078.0 107214.0 108044.0 109727.5 111888.0 1052.2 1101.6 1120.8 1124.5 1130.3 18043.4 18254.6 18346.0 18519.9 18660.2 45584.5 46164.0 46235.3 46693.5 46853.0 63475.0 64229.0 64289.0 65058.7 65067.3 9470.1 9669.6 9702.0 9887.1 9893.4 12160.0 14226.4 14354.4 14456.1 14496.5 11757.4 12206.3 12216.9 12235.9 12485.6 12136.5 12153.3 12225.5 12612.0 12724.2 12447.0 12481.9 12589.4 12665.4 12694.6 9498.9 9719.0 9766.7 9889.3 9907.3 11873.4 11940.6 12624.8 12663.1 12753.5 03:35:54 INFO - PROCESS | 10141 | 03:35:54 INFO - PROCESS | 10141 | [#3] mootools.html Cycles:180 Average:5663.17 Median:5203.03 stddev:3082.37 (59.2%) stddev-sans-first:3075.04 03:35:54 INFO - PROCESS | 10141 | Values: 1487.0 1493.8 1501.7 1515.4 1518.5 8194.7 8714.2 8715.2 8748.1 8768.1 7557.7 7818.6 8113.0 8293.0 8307.8 2369.8 2405.9 2406.3 2410.7 2414.6 2399.8 2432.1 2436.2 2451.1 2451.2 2365.1 2365.7 2381.2 2389.5 2391.3 2375.4 2376.7 2391.8 2399.6 2406.1 2317.8 2321.5 2383.5 2387.2 2394.1 8639.4 8705.1 8705.4 8710.0 8715.8 5262.3 5406.1 5415.0 5423.4 5427.2 3437.1 3452.3 3496.1 3504.6 3518.7 1384.0 1404.9 1410.8 1441.5 1526.5 11193.7 11335.6 11471.4 11873.2 11903.2 4509.1 4682.3 4718.6 4757.6 4759.7 9520.1 9526.9 9531.7 9543.7 9547.4 5396.7 5401.6 5401.7 5403.5 5407.1 4459.6 4576.2 4923.1 4983.1 4985.2 3926.5 4008.2 4025.8 4075.8 4092.2 1227.5 1240.3 1245.8 1250.3 1258.3 1027.4 1056.7 1060.7 1063.6 1067.3 5728.5 5808.3 6072.0 6085.4 6259.5 652.1 656.0 659.7 663.6 672.6 4079.1 4258.3 4281.1 4294.2 4316.5 10145.9 10474.0 10479.7 10482.4 10489.3 9803.8 10117.5 10208.8 10310.5 10419.7 8124.5 8292.4 8300.7 8309.5 8346.4 5727.7 5875.2 5904.5 5944.2 6062.1 9380.2 9528.9 9575.1 9576.2 9576.4 9788.1 9885.5 9936.7 9952.2 9958.3 6990.7 7164.2 7431.7 7490.0 7548.0 8283.7 8445.9 8449.7 8455.5 8462.8 7297.2 7359.4 7399.7 7427.7 7430.1 7445.7 7460.4 7484.9 7541.3 7571.1 6390.7 6457.6 6458.3 6471.9 6479.1 5000.8 5066.3 5069.2 5083.8 5213.5 5147.5 5190.3 5192.6 5248.0 5301.5 03:35:54 INFO - PROCESS | 10141 | 03:35:54 INFO - PROCESS | 10141 | [#4] prototype.html Cycles:180 Average:4723.91 Median:5302.23 stddev:1349.53 (25.5%) stddev-sans-first:1313.78 03:35:54 INFO - PROCESS | 10141 | Values: 403.7 405.9 416.9 419.6 425.2 5246.7 5347.7 5374.4 5420.8 5429.4 4867.9 5245.1 5252.2 5279.4 5279.9 4291.4 4309.9 4327.4 4353.2 4365.7 4334.9 4336.2 4345.2 4361.3 4362.4 4352.0 4355.1 4356.4 4361.7 4408.4 4029.4 4190.5 4192.5 4209.3 4210.0 3775.2 3776.5 3781.6 3794.9 3797.7 5254.7 5258.4 5263.3 5278.6 5287.5 4649.3 4816.7 4826.2 4865.6 4867.0 5529.3 5543.3 5545.2 5564.9 5594.7 4146.3 4147.9 4158.8 4162.3 4164.3 5513.4 5725.0 5726.6 5764.4 5779.9 4187.7 4192.6 4203.3 4205.2 4221.1 4245.8 4289.6 4295.3 4301.8 4320.0 4702.6 4735.3 4793.5 4826.1 4884.1 5575.6 5578.4 5590.2 5627.2 5631.5 1380.8 1390.3 1393.5 1411.7 1414.2 960.5 1003.4 1012.9 1013.6 1022.1 5290.6 5298.7 5330.7 5333.9 5385.5 5471.8 5492.8 5519.3 5534.2 5536.0 5042.2 5249.8 5266.3 5305.7 5310.9 2910.3 2917.8 2931.0 2948.6 2967.5 5738.5 5743.9 5745.0 5787.7 5789.3 5543.1 5600.8 5676.8 5808.0 5830.3 5760.1 5906.3 5910.4 5926.0 5964.7 5681.3 5684.5 5690.3 5754.1 5758.6 5442.6 5587.2 5598.3 5604.3 5610.3 5898.2 5926.8 5943.8 5966.7 5993.4 4042.3 4221.7 4233.4 4247.4 4260.8 5716.0 5729.6 5737.3 5743.8 5752.3 5607.7 5619.6 5624.5 5636.3 5639.3 5308.3 5542.1 5569.4 5614.2 5618.4 5571.3 5581.5 5588.5 5592.6 5595.8 5579.2 5606.6 5611.8 5641.0 5650.0 5254.2 5480.3 5502.7 5511.4 5519.2 03:35:54 INFO - PROCESS | 10141 | 03:35:54 INFO - PROCESS | 10141 | [#5] yui.html Cycles:180 Average:18621.27 Median:23494.79 stddev:23031.05 (98.0%) stddev-sans-first:23056.96 03:35:54 INFO - PROCESS | 10141 | Values: 842.0 865.1 865.7 919.5 943.2 14938.8 16881.7 17573.8 17937.6 17939.7 16276.8 16502.3 16577.1 16649.3 16689.7 704.2 730.7 846.8 859.2 860.0 814.3 847.3 857.6 861.6 862.3 900.6 904.6 904.7 906.9 907.0 732.9 761.3 901.0 901.8 901.9 630.8 647.3 655.7 657.5 658.1 16600.6 16921.0 16948.5 16992.4 17004.1 14980.4 15364.8 15474.7 15760.4 15860.7 14337.9 14349.5 14400.3 14658.2 14815.9 4039.8 4649.0 4656.5 4741.9 4808.4 72720.6 86540.6 87024.0 88783.6 90249.0 12414.2 12584.7 12643.7 12697.3 12875.0 23067.4 23098.3 23174.3 23321.3 23476.3 8528.1 8674.0 8815.1 8879.4 9242.4 4849.4 5052.9 5087.7 5106.6 5128.1 3591.3 3699.3 3700.3 3702.4 3704.4 622.2 631.8 636.9 639.9 641.8 846.5 846.9 877.8 887.3 889.4 11551.8 11688.7 11712.0 11992.5 12139.6 658.6 665.7 689.1 719.9 851.6 5066.6 5378.2 5421.2 5723.6 5860.9 66588.0 81217.0 82328.6 82467.6 83697.2 70595.6 70794.0 71472.0 72823.0 73133.3 62850.7 63243.0 63675.4 63721.0 66193.0 10727.1 10793.7 10798.4 10953.8 11031.9 40872.4 41492.8 41610.6 41872.4 42340.6 53717.7 54430.7 55168.7 55429.4 55550.4 14097.7 14138.8 14139.8 14874.2 14875.6 16474.3 16780.6 17101.6 17126.7 17315.3 15344.8 15654.5 15905.0 16168.2 16699.4 14057.6 14063.9 14086.6 14113.3 14146.7 14713.1 14825.1 15224.5 15270.5 15920.4 10264.5 10560.3 10911.7 11028.2 11083.8 11132.9 12779.9 12895.8 13086.2 13321.2 03:35:54 INFO - PROCESS | 10141 | -------- Summary: end -------- 03:35:54 INFO - PROCESS | 10141 | 03:35:54 INFO - TEST-INFO | 10141: exit 0 03:35:54 INFO - TEST-OK | dromaeo_css | took 1113106ms 03:35:54 INFO - TEST-START | kraken 03:35:54 INFO - operating with platform_type : linux_ 03:35:54 INFO - Initialising browser for kraken test... 03:35:54 INFO - TEST-INFO | started process 10458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWvKxxP/profile http://localhost:39588/getInfo.html) 03:35:58 INFO - PROCESS | 10458 | __metrics Screen width/height:1600/1200 03:35:58 INFO - PROCESS | 10458 | colorDepth:24 03:35:58 INFO - PROCESS | 10458 | Browser inner width/height: 1024/697 03:35:58 INFO - PROCESS | 10458 | __metrics 03:35:59 INFO - PROCESS | 10458 | 1486640159159 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 03:35:59 INFO - PROCESS | 10458 | 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" 03:35:59 INFO - PROCESS | 10458 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:36:00 INFO - TEST-INFO | 10458: exit 0 03:36:00 INFO - Browser initialized. 03:36:00 INFO - Running cycle 1/1 for kraken test... 03:36:00 INFO - TEST-INFO | started process 10547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWvKxxP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:12 INFO - PROCESS | 10547 | RSS: Main: 138719232 03:36:12 INFO - PROCESS | 10547 | 03:36:14 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39588/tests/kraken/driver.html?testName=audio-beat-detection) 03:36:15 INFO - PROCESS | 10547 | RSS: Main: 182947840 03:36:15 INFO - PROCESS | 10547 | 03:36:18 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39588/tests/kraken/driver.html?testName=audio-dft) 03:36:18 INFO - PROCESS | 10547 | RSS: Main: 172912640 03:36:18 INFO - PROCESS | 10547 | 03:36:21 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39588/tests/kraken/driver.html?testName=audio-fft) 03:36:21 INFO - PROCESS | 10547 | RSS: Main: 264257536 03:36:21 INFO - PROCESS | 10547 | 03:36:24 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39588/tests/kraken/driver.html?testName=audio-oscillator) 03:36:24 INFO - PROCESS | 10547 | RSS: Main: 170156032 03:36:24 INFO - PROCESS | 10547 | 03:36:26 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:36:27 INFO - PROCESS | 10547 | RSS: Main: 173019136 03:36:27 INFO - PROCESS | 10547 | 03:36:30 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39588/tests/kraken/driver.html?testName=imaging-darkroom) 03:36:30 INFO - PROCESS | 10547 | RSS: Main: 211324928 03:36:30 INFO - PROCESS | 10547 | 03:36:34 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39588/tests/kraken/driver.html?testName=imaging-desaturate) 03:36:34 INFO - PROCESS | 10547 | RSS: Main: 210591744 03:36:34 INFO - PROCESS | 10547 | 03:36:37 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39588/tests/kraken/driver.html?testName=json-parse-financial) 03:36:38 INFO - PROCESS | 10547 | RSS: Main: 208543744 03:36:38 INFO - PROCESS | 10547 | 03:36:39 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:40 INFO - PROCESS | 10547 | RSS: Main: 170557440 03:36:40 INFO - PROCESS | 10547 | 03:36:42 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39588/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:36:42 INFO - PROCESS | 10547 | RSS: Main: 178266112 03:36:42 INFO - PROCESS | 10547 | 03:36:44 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:45 INFO - PROCESS | 10547 | RSS: Main: 187072512 03:36:45 INFO - PROCESS | 10547 | 03:36:47 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:48 INFO - PROCESS | 10547 | RSS: Main: 191516672 03:36:48 INFO - PROCESS | 10547 | 03:36:51 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:51 INFO - PROCESS | 10547 | RSS: Main: 192733184 03:36:51 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:39588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39588/tests/kraken/driver.html?testName=ai-astar) 03:36:53 INFO - PROCESS | 10547 | RSS: Main: 245280768 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | __start_tp_report 03:36:53 INFO - PROCESS | 10547 | _x_x_mozilla_page_load 03:36:53 INFO - PROCESS | 10547 | _x_x_mozilla_page_load_details 03:36:53 INFO - PROCESS | 10547 | |i|pagename|runs| 03:36:53 INFO - PROCESS | 10547 | |0;ai-astar;111;112;113;114;114;113;112;112;114;113 03:36:53 INFO - PROCESS | 10547 | |1;audio-beat-detection;149;116;119;149;124;127;117;116;139;118 03:36:53 INFO - PROCESS | 10547 | |2;audio-dft;162;161;161;161;161;160;161;162;160;161 03:36:53 INFO - PROCESS | 10547 | |3;audio-fft;74;75;76;108;77;77;76;76;89;74 03:36:53 INFO - PROCESS | 10547 | |4;audio-oscillator;84;82;106;82;82;82;93;81;82;106 03:36:53 INFO - PROCESS | 10547 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;118;117;117 03:36:53 INFO - PROCESS | 10547 | |6;imaging-darkroom;146;146;147;147;146;146;148;146;147;146 03:36:53 INFO - PROCESS | 10547 | |7;imaging-desaturate;96;95;96;96;96;95;96;96;97;96 03:36:53 INFO - PROCESS | 10547 | |8;json-parse-financial;48;59;47;47;48;50;48;50;48;49 03:36:53 INFO - PROCESS | 10547 | |9;json-stringify-tinderbox;66;66;66;65;67;65;65;65;65;69 03:36:53 INFO - PROCESS | 10547 | |10;stanford-crypto-aes;77;77;77;77;79;77;77;81;77;76 03:36:53 INFO - PROCESS | 10547 | |11;stanford-crypto-ccm;130;125;123;126;122;127;120;122;211;131 03:36:53 INFO - PROCESS | 10547 | |12;stanford-crypto-pbkdf2;161;165;158;160;165;165;159;161;166;172 03:36:53 INFO - PROCESS | 10547 | |13;stanford-crypto-sha256-iterative;63;61;60;61;61;59;60;60;60;60 03:36:53 INFO - PROCESS | 10547 | __end_tp_report 03:36:53 INFO - PROCESS | 10547 | __start_cc_report 03:36:53 INFO - PROCESS | 10547 | _x_x_mozilla_cycle_collect,1493 03:36:53 INFO - PROCESS | 10547 | __end_cc_report 03:36:53 INFO - PROCESS | 10547 | __startTimestamp1486640213736__endTimestamp 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | ------- Summary: start ------- 03:36:53 INFO - PROCESS | 10547 | Number of tests: 14 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.03 (0.9%) stddev-sans-first:0.87 03:36:53 INFO - PROCESS | 10547 | Values: 111.0 112.0 113.0 114.0 114.0 113.0 112.0 112.0 114.0 113.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:125.50 stddev:13.36 (10.6%) stddev-sans-first:11.66 03:36:53 INFO - PROCESS | 10547 | Values: 149.0 116.0 119.0 149.0 124.0 127.0 117.0 116.0 139.0 118.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 03:36:53 INFO - PROCESS | 10547 | Values: 162.0 161.0 161.0 161.0 161.0 160.0 161.0 162.0 160.0 161.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.00 stddev:10.69 (14.1%) stddev-sans-first:11.10 03:36:53 INFO - PROCESS | 10547 | Values: 74.0 75.0 76.0 108.0 77.0 77.0 76.0 76.0 89.0 74.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:82.00 stddev:10.10 (12.3%) stddev-sans-first:10.61 03:36:53 INFO - PROCESS | 10547 | Values: 84.0 82.0 106.0 82.0 82.0 82.0 93.0 81.0 82.0 106.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:36:53 INFO - PROCESS | 10547 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 03:36:53 INFO - PROCESS | 10547 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 148.0 146.0 147.0 146.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:36:53 INFO - PROCESS | 10547 | Values: 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:48.50 stddev:3.53 (7.3%) stddev-sans-first:3.71 03:36:53 INFO - PROCESS | 10547 | Values: 48.0 59.0 47.0 47.0 48.0 50.0 48.0 50.0 48.0 49.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.29 (1.9%) stddev-sans-first:1.36 03:36:53 INFO - PROCESS | 10547 | Values: 66.0 66.0 66.0 65.0 67.0 65.0 65.0 65.0 65.0 69.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:1.43 (1.9%) stddev-sans-first:1.51 03:36:53 INFO - PROCESS | 10547 | Values: 77.0 77.0 77.0 77.0 79.0 77.0 77.0 81.0 77.0 76.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:126.50 stddev:27.39 (21.7%) stddev-sans-first:29.02 03:36:53 INFO - PROCESS | 10547 | Values: 130.0 125.0 123.0 126.0 122.0 127.0 120.0 122.0 211.0 131.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:165.00 stddev:4.21 (2.6%) stddev-sans-first:4.39 03:36:53 INFO - PROCESS | 10547 | Values: 161.0 165.0 158.0 160.0 165.0 165.0 159.0 161.0 166.0 172.0 03:36:53 INFO - PROCESS | 10547 | 03:36:53 INFO - PROCESS | 10547 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:60.50 stddev:1.08 (1.8%) stddev-sans-first:0.67 03:36:53 INFO - PROCESS | 10547 | Values: 63.0 61.0 60.0 61.0 61.0 59.0 60.0 60.0 60.0 60.0 03:36:53 INFO - PROCESS | 10547 | -------- Summary: end -------- 03:36:53 INFO - PROCESS | 10547 | 03:36:54 INFO - TEST-INFO | 10547: exit 0 03:36:54 INFO - TEST-OK | kraken | took 59911ms 03:36:54 INFO - SUITE-END | took 1173s 03:36:54 INFO - Completed test suite (00:19:33) 03:36:54 INFO - javascript benchmark 03:36:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3170.239142605774, 3192.0264319382577, 3215.855286512107, 3246.7727259091857, 3257.3485302939403, 5383.219433182187, 5387.1111266641055, 5411.107167317393, 5415.783368665258, 5468.070428027235, 5443.2107344435035, 5484.698341591211, 5503.9174412383745, 5565.582581306398, 5588.497035266825, 5070.695758254507, 5091.083604951126, 5110.948890511103, 5167.3282473278605, 5169.353830771153, 4981.476944920767, 5017.673851199678, 5027.296178535008, 5094.770735316901, 5106.948930510703, 4987.875303117415, 5091.210862316347, 5097.541221290083, 5119.436861945183, 5131.358580177478, 5111.361079865017, 5111.952049829776, 5122.205017649913, 5123.5901127909865, 5152.201408781645, 4805.543473370024, 4825.372701548777, 4968.552830245295, 4985.351904252424, 5056.595472362203, 5420.430854760233, 5473.698946557938, 5490.039243132475, 5536.557075433956, 5575.0522411190195, 5943.108533719934, 5983.222181116427, 5997.850053748648, 5998.910016349758, 6000.159977603139, 5860.589758716891, 5996.040633498619, 6013.398660133952, 6016.127661489103, 6018.789342373039, 5438.885028569134, 5487.6158668893195, 5489.176623506466, 5556.749946252428, 5594.776208951596, 5989.921814073421, 5995.160677505153, 6000.519958403317, 6005.249343832021, 6020.909686354708, 5744.827655170351, 5807.0998995155815, 5814.011618024946, 5815.912761308584, 5816.389279125716, 5694.772209111589, 5718.399568045295, 5747.453991870766, 5758.424157584208, 5855.180274761537, 5792.478676919098, 5836.299644042742, 5840.065589505659, 5850.385709500526, 5856.912146317809, 5815.04051831443, 5833.50415214703, 5842.824715258549, 5847.883042339215, 5854.560907931922, 4373.387725718402, 4378.16814805186, 4417.867463976086, 4418.447694038246, 4451.265541185668, 4075.8505852821913, 4077.938830917539, 4087.2438598859308, 4103.4460347853255, 4113.670906327487, 5751.0, 5751.568632352591, 5751.913721294184, 5753.62601430914, 5765.769369225268, 5790.131480277992, 5798.88402231953, 5850.882982340329, 5859.355470898197, 5904.143899134688, 5706.172604972256, 5709.628874123252, 5709.942900571024, 5715.057015592464, 5730.398308177581, 5044.899102017939, 5046.142155833517, 5054.873628159326, 5055.646104772631, 5056.570191533688, 5951.285845698458, 6001.039833626686, 6017.699115044143, 6018.999999999913, 6137.0794380842335, 5913.763449461973, 5915.6450612961635, 5915.970420147872, 5933.495652869555, 5947.167396564571, 6100.54245931548, 6103.42017508336, 6105.84735381619, 6109.908351374644, 6146.938530614637, 5691.857703557279, 5728.054870946247, 5778.508826749773, 5804.709764511842, 5828.53371730269, 5810.912836307374, 5879.588428809942, 5898.0, 5930.881382372415, 5992.640441573345, 5820.621659592113, 5827.854303642443, 5829.09649004405, 5831.446012628793, 5832.504237139721, 5758.856028599319, 5813.534917206529, 5816.41835816415, 5822.359540450631, 5824.621399609012, 5623.156526520891, 5673.574481913955, 5706.514946229451, 5740.885182296414, 5747.885042299215, 5822.417758224144, 5824.825255242349, 5836.474717275466, 5838.824835254949, 5869.53043756507, 5704.172894930295, 5709.0865461525955, 5710.885782284248, 5713.800016999385, 5716.28546431696], "value": 5447.827995369022, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.1175964821776, 578.6123297390748, 617.9710781548723, 623.2365352443258, 657.3196741372681, 39584.99999999996, 47011.76494117529, 48569.51430485699, 48609.756951215284, 53461.73269133658, 51608.74195629016, 52040.47959520404, 52188.0, 52203.73898130504, 52203.738981305134, 9322.067793220675, 9499.097585729345, 9508.904910950905, 9513.238940884712, 9515.238780897545, 8267.090620031791, 8447.113053129426, 10985.61550345738, 11234.887651123467, 11249.83125253122, 11404.942975285112, 11475.368854712988, 11485.885141148607, 11489.59786407476, 11498.080153587734, 11416.372099534523, 11486.827697584544, 11501.0, 11507.712307192303, 11511.654650360502, 11263.43682815856, 11315.3210807351, 11316.547338106466, 11319.547218111265, 11321.377324247163, 49080.0, 49454.50545494535, 49643.25535116976, 49646.50353496455, 49653.75173124147, 4342.804573794187, 4496.7301961882395, 4537.636989040869, 4556.134334476472, 4732.952670473285, 32452.83773581117, 32581.348373032644, 32620.836895815606, 32851.0, 33573.83213083944, 4312.33158860374, 4326.480822301312, 4365.541618130114, 4371.169477799208, 4375.2124617568825, 380649.0, 382333.0, 382518.0, 382562.0, 383721.0, 60552.0, 61561.07658385128, 61599.0, 61646.0753088704, 61707.074393884126, 63339.366606333344, 63655.68172159109, 63728.0, 63745.68127159427, 63756.36243637504, 18959.052047397574, 19605.31381401644, 19626.803731962784, 19628.0, 19652.21391144367, 13700.314984250748, 14079.788803167961, 15180.696386072217, 15300.693986120215, 15321.23393830304, 19155.61688766217, 19587.634018943616, 20574.69137962932, 20581.279655211994, 20693.17227310921, 7423.554586724814, 7586.0, 7596.025033491332, 7691.461597688108, 7816.726414575576, 994.6021591363368, 1025.2310766924807, 1025.4923812712755, 1043.7338478687886, 1049.8530205771199, 34297.31405371879, 34593.0, 34701.82649086738, 34836.477452838226, 35522.82238588791, 1148.494662348564, 1175.1715040896318, 1197.634721409961, 1225.8099994500867, 1232.2975903734784, 18386.81613183878, 18451.16969736338, 18637.534061648297, 18722.719159212622, 18767.155478003522, 539796.0, 545253.0, 547878.0, 548160.0, 548701.0, 69455.0, 70441.64779176071, 70499.2950070503, 70545.0, 70612.29387706057, 1541.2756004677783, 1573.622330640661, 1592.633694250329, 1597.3770229610461, 1609.4045203274864, 32538.34923301568, 33641.495377569845, 33711.66288337085, 33775.723232925935, 34088.318233635684, 58093.0, 58728.0, 58802.0, 58871.0, 58882.0, 378658.0, 378747.0, 379444.0, 382838.68645254994, 383521.0, 27790.0, 28475.006749527332, 31335.21661958469, 31825.5226171603, 48263.27605085856, 50904.0, 51189.232161518354, 55857.0, 55983.0, 57026.0, 45027.549724502336, 47559.0, 47628.52371476241, 47678.0, 48933.51066489289, 45483.31775023443, 47779.28331074967, 48041.0, 48061.279080814515, 49076.26385604147, 46522.76738616285, 46997.53002470068, 48251.75874120607, 48308.51691483181, 48458.27312590244, 39638.2072358557, 41970.790146049076, 42109.0, 42198.78900605477, 42409.36385954275, 31196.220094497818, 31552.368952621277, 31576.789829678764, 31844.68155318417, 31914.52128218032], "value": 22419.727056167994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.74087713424825, 433.96962212645127, 438.3512401645565, 441.0417745211263, 447.946246450426, 18547.0, 20931.686024709623, 22083.6687449688, 22490.325290241297, 22645.77354226457, 22498.43753906153, 22687.773122268773, 22785.658215126747, 23011.539769204646, 23130.884345578248, 5347.54545863602, 5995.52035837132, 6207.162033125538, 6816.931830681704, 6871.931280687204, 6773.559718618299, 6815.148106486689, 6972.686229119677, 6973.093497845273, 6981.301869813004, 6838.6580670966505, 6887.139107611549, 6889.242183359826, 6892.862142757167, 6892.965535172317, 6733.46132309414, 6851.38337549618, 6882.518223724316, 6890.965545172267, 6900.7929762107215, 6109.297430795471, 6123.6938153092615, 6136.23297087864, 6136.631802091844, 6139.048447490646, 25376.0, 25440.872795635903, 25454.36364090894, 25481.87259063693, 25915.22254332373, 2800.845953472558, 2956.7782416318864, 2985.507391280436, 3002.369502404498, 3028.303490197245, 11127.332360058423, 11301.547938082467, 11500.884991150066, 11506.88493115075, 11663.94168029163, 2005.4886004069015, 2049.1803278688494, 2058.084152552115, 2069.4412508622736, 2098.370488853338, 89548.0, 98247.50876245573, 98888.0, 99370.50314748452, 100267.9973200266, 10411.583536658449, 10972.670819875417, 11574.363410012362, 12154.0, 12363.75272494545, 16631.750523742154, 17354.913225433793, 17434.47696569105, 18290.0, 18393.0, 9556.378835375679, 9601.90398096024, 9662.08210220028, 9733.124018838338, 9813.0, 9205.585748641328, 9284.95357523208, 9369.484678342757, 9421.24630029596, 9559.187469065208, 5440.972795135999, 5490.231367608538, 5501.642393244426, 5512.6968016758665, 5575.107982722745, 2203.9559208816054, 2244.450109723128, 2266.9093236270696, 2320.071971211495, 2335.07764433048, 928.2481190235931, 939.2392162348519, 943.6508491858057, 946.5172761891484, 958.4393130018877, 19459.708104378446, 21088.261910833047, 21288.36134915955, 21406.0, 21489.355319340444, 933.5005771911995, 936.3585943628636, 945.6406565505201, 952.5713428956997, 962.6775030364767, 10996.560137594566, 11544.94227528857, 11658.417079146178, 11740.471678774476, 11797.35114568707, 297787.0, 401960.0, 740282.0, 747030.0, 748955.0, 107078.0, 107214.0, 108044.0, 109727.45136274428, 111888.0, 1052.2055847834836, 1101.5648818716722, 1120.7590368070742, 1124.4658787076073, 1130.2992144870234, 18043.368482103062, 18254.634907302046, 18346.0, 18519.90740046291, 18660.160292786586, 45584.54415455803, 46164.0, 46235.306470403644, 46693.53306466892, 46853.0, 63475.0, 64229.0, 64289.0, 65058.67470662617, 65067.349326506126, 9470.100340467645, 9669.613215471303, 9702.0, 9887.110160085627, 9893.35693179941, 12160.0, 14226.430942762587, 14354.354054067384, 14456.060356076821, 14496.492622758153, 11757.412129393326, 12206.267623942593, 12216.938915305367, 12235.877641223475, 12485.56300529477, 12136.514539418324, 12153.331566763913, 12225.510979560719, 12612.0, 12724.236545807282, 12447.0, 12481.93759031199, 12589.43347549344, 12665.366731663564, 12694.555690551157, 9498.905010949802, 9719.0, 9766.658166964122, 9889.258305626963, 9907.306488545733, 11873.406329683308, 11940.641780746591, 12624.810627840407, 12663.113582049167, 12753.48986040585], "value": 10280.449458659457, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.0, 1493.7759336099584, 1501.6996600679863, 1515.439287463638, 1518.5216656753119, 8194.672213111477, 8714.17215364541, 8715.172058654425, 8748.081451447602, 8768.123187681229, 7557.735479258227, 7818.569978651172, 8112.959435202816, 8293.0, 8307.750767476986, 2369.786719195268, 2405.903763849453, 2406.3262286559793, 2410.7227668818136, 2414.61366181411, 2399.7960173385195, 2432.136591510015, 2436.1717016214484, 2451.080844683244, 2451.203358908353, 2365.1367250953363, 2365.6924599802, 2381.1903952656094, 2389.486260454002, 2391.2945681024053, 2375.3824005758543, 2376.6910301660846, 2391.7847393734473, 2399.5800734871327, 2406.1217655555683, 2317.8261630377788, 2321.5356928614347, 2383.487550176703, 2387.152560840894, 2394.114177754242, 8639.39524233304, 8705.085965973545, 8705.390622656416, 8709.95645021777, 8715.825683486359, 5262.2632831403635, 5406.08096623575, 5414.972925135349, 5423.430539793344, 5427.240186373911, 3437.123533498967, 3452.2577645806273, 3496.1434448560267, 3504.5794504659602, 3518.736094792875, 1383.969107654234, 1404.9157050576998, 1410.8024876517295, 1441.5242969819935, 1526.4962562354397, 11193.72015699614, 11335.603253886156, 11471.369074700888, 11873.228240164448, 11903.22629029119, 4509.098180363941, 4682.297655351725, 4718.598919091915, 4757.643176761757, 4759.6668233223345, 9520.143187113194, 9526.90473095274, 9531.714048578553, 9543.713688589354, 9547.379420337656, 5396.730163491809, 5401.567874570025, 5401.7029063401105, 5403.5136837684795, 5407.080796264644, 4459.620932220732, 4576.222042252758, 4923.064617722621, 4983.127952608279, 4985.202367621163, 3926.528816541976, 4008.198360327946, 4025.7785821780085, 4075.7962101894786, 4092.202020606013, 1227.533537255855, 1240.3054289597853, 1245.7944439167618, 1250.2995925541256, 1258.2639156093605, 1027.3733022856052, 1056.7358160459885, 1060.6870973062964, 1063.6330465989377, 1067.2742535076222, 5728.48443640066, 5808.30300363959, 6072.0, 6085.391460853968, 6259.530535209878, 652.1228947066188, 655.9770408035696, 659.7328082126746, 663.6250518457057, 672.5661948043485, 4079.082206503513, 4258.297380932111, 4281.143771245764, 4294.184105020036, 4316.503602085738, 10145.94927025375, 10474.0, 10479.738006549896, 10482.37105773656, 10489.265751397481, 9803.803923921481, 10117.544710488046, 10208.846867296996, 10310.484475776331, 10419.687409377731, 8124.512529248264, 8292.419530632798, 8300.667973281123, 8309.501429914224, 8346.374021948257, 5727.7422515986045, 5875.20684707559, 5904.468597826216, 5944.167816505606, 6062.120992455981, 9380.155785979294, 9528.904710953078, 9575.138237558653, 9576.23390128774, 9576.425414475154, 9788.119069283799, 9885.50572471388, 9936.652217172365, 9952.203823693942, 9958.253131015057, 6990.6504674767075, 7164.211936687065, 7431.739889103856, 7490.0, 7548.0, 8283.710070147516, 8445.915540844759, 8449.746507604781, 8455.492670439793, 8462.788430289293, 7297.16082650502, 7359.411247100326, 7399.667014984447, 7427.740029098955, 7430.108386993596, 7445.664945077593, 7460.4031677466755, 7484.887726684213, 7541.321281084729, 7571.129320128035, 6390.7443702251385, 6457.61254324742, 6458.257300410513, 6471.870562588816, 6479.125318081999, 5000.849974500771, 5066.316047333563, 5069.239614057921, 5083.771230294572, 5213.504717051874, 5147.485251474973, 5190.273361729436, 5192.5586325162785, 5247.973760131327, 5301.5493683037375], "value": 4585.844206697868, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.67302484987164, 405.92287465381577, 416.9312063509521, 419.6495925901873, 425.1730384402339, 5246.685198888069, 5347.652402593833, 5374.355077390714, 5420.810271640494, 5429.375621803494, 4867.902641947159, 5245.134552798783, 5252.185911183763, 5279.366476022873, 5279.894402111955, 4291.4421125253675, 4309.913801723971, 4327.394164816928, 4353.194658988082, 4365.712114926105, 4334.934975975347, 4336.1978034063795, 4345.174416860787, 4361.34579813029, 4362.389265502832, 4352.0, 4355.085432059255, 4356.43366362374, 4361.666508417997, 4408.360787685784, 4029.355303151496, 4190.497140343148, 4192.454980852485, 4209.284421648296, 4209.958170287408, 3775.2449510097817, 3776.527934008249, 3781.621837816196, 3794.918448242238, 3797.715171362159, 5254.710990895499, 5258.421573626898, 5263.31576895005, 5278.630495865253, 5287.524122828925, 4649.302604609302, 4816.7350795706225, 4826.203676393391, 4865.635077369211, 4866.975665121652, 5529.30883639545, 5543.334799824047, 5545.168224766277, 5564.944350556483, 5594.74118323378, 4146.3365861462025, 4147.875563733093, 4158.795838205726, 4162.271602469556, 4164.271252530825, 5513.421090785449, 5724.971375143139, 5726.599138060337, 5764.394738552433, 5779.855503612402, 4187.685923555746, 4192.601702838226, 4203.285441474956, 4205.17998990194, 4221.134667393177, 4245.80893859777, 4289.571042895685, 4295.334223195409, 4301.763403012802, 4319.9784001080425, 4702.623790096853, 4735.337052812609, 4793.472718001017, 4826.083044221657, 4884.145274577006, 5575.553955683536, 5578.386377498472, 5590.217369568264, 5627.240322556484, 5631.549476041907, 1380.792881067848, 1390.3048475762118, 1393.512270705245, 1411.710599327156, 1414.2433797918065, 960.5389413081759, 1003.3628645809963, 1012.8683271174848, 1013.5793645636978, 1022.1414012229762, 5290.629655924048, 5298.735063246822, 5330.680159190461, 5333.853221557384, 5385.461453854661, 5471.753771080311, 5492.80775172867, 5519.31008623922, 5534.1975413565615, 5535.972320138454, 5042.243663450438, 5249.763760630781, 5266.2890509781455, 5305.734713264322, 5310.893782124336, 2910.3160757222035, 2917.7957542972213, 2931.0327591894625, 2948.557716342566, 2967.4658561458714, 5738.540916726652, 5743.85640358986, 5744.971275143681, 5787.71061446926, 5789.305283366023, 5543.113101903757, 5600.775968961278, 5676.801311954062, 5808.0, 5830.271216097988, 5760.107183386582, 5906.316699740553, 5910.4385083417865, 5925.962956482685, 5964.701764911824, 5681.346645135863, 5684.488396044376, 5690.317161940594, 5754.136879468113, 5758.62568933018, 5442.591805614516, 5587.245721827664, 5598.3282006159525, 5604.299462567179, 5610.326760788732, 5898.233229680286, 5926.7925622603, 5943.821685349447, 5966.671833049224, 5993.4006599341465, 4042.2521833460905, 4221.683373747042, 4233.364995250737, 4247.405363249086, 4260.808263628206, 5716.0, 5729.598928074995, 5737.282839645044, 5743.822516384048, 5752.33848107473, 5607.747651355618, 5619.634723742944, 5624.456592346795, 5636.267285252891, 5639.336395763342, 5308.283381743569, 5542.11326187808, 5569.443055694398, 5614.242077319673, 5618.410066942912, 5571.303587051619, 5581.469760372758, 5588.541041941533, 5592.608517403743, 5595.832125036255, 5579.214651311704, 5606.551475882001, 5611.775528978795, 5641.0, 5650.0, 5254.185601231662, 5480.287562616834, 5502.697351645698, 5511.448855114457, 5519.227308176939], "value": 4313.695417443874, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.0, 865.0916537635485, 865.6710450028988, 919.4988731141527, 943.1747221181466, 14938.77591836122, 16881.746773798386, 17573.824261757378, 17937.64124717505, 17939.73090403645, 16276.75584866228, 16502.25739841707, 16577.088260145687, 16649.33402663892, 16689.749653755203, 704.2499737779274, 730.7332823519404, 846.8264005878796, 859.1537335724306, 860.0410542245414, 814.2590242878981, 847.2925107535216, 857.6140736668524, 861.5692153923038, 862.3446180902528, 900.5632268349846, 904.6200595749768, 904.6878826804742, 906.9138431848963, 907.0340087806497, 732.9010583571203, 761.2996043639864, 901.0313912544009, 901.8106197698492, 901.8647202919582, 630.8265227062549, 647.3041480408533, 655.7278729327323, 657.5068698476143, 658.0852614865341, 16600.584985375343, 16921.0, 16948.491545253662, 16992.40526581576, 17004.06477643729, 14980.400783968627, 15364.846351536453, 15474.690506189812, 15760.369585216578, 15860.682786344209, 14337.856621433757, 14349.497767578085, 14400.279986000764, 14658.193799341032, 14815.851841481555, 4039.7576145431367, 4649.0, 4656.4645065817185, 4741.905161896777, 4808.350872632185, 72720.63639681821, 86540.56729716374, 87024.0, 88783.55608221982, 90249.0, 12414.193077449936, 12584.685382865502, 12643.747125057447, 12697.301648409426, 12875.0, 23067.423314417272, 23098.307050788502, 23174.304770856903, 23321.300360989197, 23476.295711128692, 8528.061913189544, 8673.956630216935, 8815.074417186232, 8879.422837515542, 9242.445453272825, 4849.393825771778, 5052.850459192499, 5087.694738315713, 5106.591472682177, 5128.1282182029145, 3591.317649646559, 3699.3341198584512, 3700.3339398907915, 3702.3891057975134, 3704.388775852008, 622.1694038458709, 631.8199313195718, 636.9299377068519, 639.9008153736179, 641.7914177892204, 846.4794151596724, 846.9497822699808, 877.7937184761576, 887.2502735188755, 889.3907673243849, 11551.76896462083, 11688.70778230551, 11712.0, 11992.520299187934, 12139.575114870937, 658.5916731626422, 665.690453938911, 689.1248114894056, 719.9208087110413, 851.6040041380787, 5066.620003499752, 5378.19327100938, 5421.241026256327, 5723.59934804568, 5860.941390586125, 66588.0, 81217.0, 82328.58835705783, 82467.58766206131, 83697.16302836893, 70595.64702176559, 70794.0, 71472.0, 72823.0, 73133.2686673137, 62850.685746571886, 63243.0, 63675.36324636694, 63721.0, 66193.00710489346, 10727.141828653845, 10793.669698819358, 10798.352098874093, 10953.83569246478, 11031.889681103086, 40872.386914196904, 41492.79253603713, 41610.58389416067, 41872.3719144207, 42340.576594233666, 53717.73141134269, 54430.72784636052, 55168.724156378965, 55429.44570554243, 55550.444495554526, 14097.718045639234, 14138.78791818144, 14139.787903181255, 14874.181919994504, 14875.628109297355, 16474.325565234943, 16780.58048548796, 17101.57246068858, 17126.657466850345, 17315.307387704856, 15344.846551534341, 15654.452094177104, 15905.0, 16168.191590420667, 16699.415520456725, 14057.578272651837, 14063.929680351534, 14086.647833804236, 14113.2943352834, 14146.717065658835, 14713.117212967256, 14825.110493370432, 15224.543263702106, 15270.541883743506, 15920.442784502487, 10264.486775661038, 10560.313579617301, 10911.672649820519, 11028.172887033345, 11083.833742493707, 11132.88867111351, 12779.936100319439, 12895.806562901376, 13086.214827110403, 13321.200727956353], "value": 7842.7162855746565, "unit": "score"}], "name": "dromaeo_css", "value": 7613.923138288186, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 113.0, 114.0, 114.0, 113.0, 112.0, 112.0, 114.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 119.0, 149.0, 124.0, 127.0, 117.0, 116.0, 139.0, 118.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 108.0, 77.0, 77.0, 76.0, 76.0, 89.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 106.0, 82.0, 82.0, 82.0, 93.0, 81.0, 82.0, 106.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 59.0, 47.0, 47.0, 48.0, 50.0, 48.0, 50.0, 48.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 65.0, 65.0, 65.0, 65.0, 69.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 77.0, 79.0, 77.0, 77.0, 81.0, 77.0, 76.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 125.0, 123.0, 126.0, 122.0, 127.0, 120.0, 122.0, 211.0, 131.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 158.0, 160.0, 165.0, 165.0, 159.0, 161.0, 166.0, 172.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 60.0, 61.0, 61.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 60.5, "unit": "score"}], "name": "kraken", "value": 1479.2, "alertThreshold": 2.0}]} 03:36:54 INFO - Return code: 0 03:36:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:36:55 ERROR - # TBPL SUCCESS # 03:36:55 INFO - Running post-action listener: _resource_record_post_action 03:36:55 INFO - [mozharness: 2017-02-09 11:36:55.035845Z] Finished run-tests step (success) 03:36:55 INFO - Running post-run listener: _resource_record_post_run 03:36:55 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 365682688; Read time: 332; Write time: 177700 03:36:55 INFO - TinderboxPrint: CPU usage
13.0% 03:36:55 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 332 03:36:55 INFO - TinderboxPrint: I/O write bytes / time
365,682,688 / 177,700 03:36:55 INFO - TinderboxPrint: CPU idle
8,263.1 (87.0%) 03:36:55 INFO - TinderboxPrint: CPU user
1,191.6 (12.5%) 03:36:55 INFO - TinderboxPrint: Swap in / out
0 / 0 03:36:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109391872; Read time: 156; Write time: 67444 03:36:55 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 256290816; Read time: 176; Write time: 110256 03:36:55 INFO - Running post-run listener: _upload_blobber_files 03:36:55 INFO - Blob upload gear active. 03:36:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:55 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 03:36:55 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', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:36:55 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 Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:36:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:36:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:36:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:57 INFO - (blobuploader) - INFO - Done attempting. 03:36:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:36:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:37:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:00 INFO - (blobuploader) - INFO - Done attempting. 03:37:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:37:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:37:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:00 INFO - (blobuploader) - INFO - Done attempting. 03:37:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:37:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:37:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:01 INFO - (blobuploader) - INFO - Done attempting. 03:37:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:37:01 INFO - Return code: 0 03:37:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:37:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:37:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5db72d264f9f89a9324771a5a102238ea661b992d7ce81b0c5df0b65f095b9d50fc5cf007a3a582ed509b8cb1f3185934338da0976cd0f855e41fe806c14cb02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9821602598fef981ab79415af9f9e7472571bdaed1f69c1758772d9042a05ac1bddb30f4e46b20c42122e52a40366fcc86a195953a0eadaf3a3b1c30c54e547b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a56e119ccafb52be112839ec0ae0bc5a11b34cd8bea40c6f3064dc388d715fa8aa5cedc526d6a5c239a993660096100151832fbc0c317e291b6e98f9dcd7e19a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9fd94f775a84ce0f5c7627cd2f487a90876fd3a4fd3f7ca4721035648aa60cbd0eb18bc763aa0ddf798e6fdf25ea4059a714e40c8e7ead8019c6c2af3125ab09"} 03:37:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:37:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:37:01 INFO - Contents: 03:37:01 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5db72d264f9f89a9324771a5a102238ea661b992d7ce81b0c5df0b65f095b9d50fc5cf007a3a582ed509b8cb1f3185934338da0976cd0f855e41fe806c14cb02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9821602598fef981ab79415af9f9e7472571bdaed1f69c1758772d9042a05ac1bddb30f4e46b20c42122e52a40366fcc86a195953a0eadaf3a3b1c30c54e547b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a56e119ccafb52be112839ec0ae0bc5a11b34cd8bea40c6f3064dc388d715fa8aa5cedc526d6a5c239a993660096100151832fbc0c317e291b6e98f9dcd7e19a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9fd94f775a84ce0f5c7627cd2f487a90876fd3a4fd3f7ca4721035648aa60cbd0eb18bc763aa0ddf798e6fdf25ea4059a714e40c8e7ead8019c6c2af3125ab09"} 03:37:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:37:01 INFO - Copying logs to upload dir... 03:37:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:37:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.742507 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-09 03:37:01.070970) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 03:37:01.074410) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5db72d264f9f89a9324771a5a102238ea661b992d7ce81b0c5df0b65f095b9d50fc5cf007a3a582ed509b8cb1f3185934338da0976cd0f855e41fe806c14cb02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9821602598fef981ab79415af9f9e7472571bdaed1f69c1758772d9042a05ac1bddb30f4e46b20c42122e52a40366fcc86a195953a0eadaf3a3b1c30c54e547b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a56e119ccafb52be112839ec0ae0bc5a11b34cd8bea40c6f3064dc388d715fa8aa5cedc526d6a5c239a993660096100151832fbc0c317e291b6e98f9dcd7e19a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9fd94f775a84ce0f5c7627cd2f487a90876fd3a4fd3f7ca4721035648aa60cbd0eb18bc763aa0ddf798e6fdf25ea4059a714e40c8e7ead8019c6c2af3125ab09"} build_url:https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/A0QRacE4SL6o3ZIeILfrYQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5db72d264f9f89a9324771a5a102238ea661b992d7ce81b0c5df0b65f095b9d50fc5cf007a3a582ed509b8cb1f3185934338da0976cd0f855e41fe806c14cb02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9821602598fef981ab79415af9f9e7472571bdaed1f69c1758772d9042a05ac1bddb30f4e46b20c42122e52a40366fcc86a195953a0eadaf3a3b1c30c54e547b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a56e119ccafb52be112839ec0ae0bc5a11b34cd8bea40c6f3064dc388d715fa8aa5cedc526d6a5c239a993660096100151832fbc0c317e291b6e98f9dcd7e19a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9fd94f775a84ce0f5c7627cd2f487a90876fd3a4fd3f7ca4721035648aa60cbd0eb18bc763aa0ddf798e6fdf25ea4059a714e40c8e7ead8019c6c2af3125ab09"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 03:37:01.102268) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:37:01.102602) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1486638984.672103-2125781908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:37:01.188819) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 03:37:01.189458) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 03:37:01.190111) ========= ========= Total master_lag: 0.25 =========