builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1492490916.24 results: success (0) revision: 105e456d811b8c4616de688e9afdcf0af620b80b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:36.241486) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:36.242026) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:36.242329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:36.257516) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:36.257931) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-17 21:48:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-04-17 21:48:36 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099148 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:36.372282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:36.372621) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017397 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:36.422090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 21:48:36.422436) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 105e456d811b8c4616de688e9afdcf0af620b80b --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 105e456d811b8c4616de688e9afdcf0af620b80b --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=56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-17 21:48:36,516 truncating revision to first 12 chars 2017-04-17 21:48:36,516 Setting DEBUG logging. 2017-04-17 21:48:36,516 attempt 1/10 2017-04-17 21:48:36,516 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/105e456d811b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-17 21:48:37,319 unpacking tar archive at: mozilla-aurora-105e456d811b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.167944 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 21:48:37.604543) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:37.604874) ========= script_repo_revision: 105e456d811b8c4616de688e9afdcf0af620b80b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:37.605319) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:37.605624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 21:48:37.615679) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-17 21:48:37.615987) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:48:37 INFO - MultiFileLogger online at 20170417 21:48:37 in /builds/slave/test 21:48:37 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 21:48:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:48:37 INFO - {'append_to_log': False, 21:48:37 INFO - 'base_work_dir': '/builds/slave/test', 21:48:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 21:48:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:48:37 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 21:48:37 INFO - 'buildbot_json_path': 'buildprops.json', 21:48:37 INFO - 'config_files': ('talos/linux_config.py',), 21:48:37 INFO - 'default_actions': ('clobber', 21:48:37 INFO - 'read-buildbot-config', 21:48:37 INFO - 'download-and-extract', 21:48:37 INFO - 'populate-webroot', 21:48:37 INFO - 'create-virtualenv', 21:48:37 INFO - 'install', 21:48:37 INFO - 'run-tests'), 21:48:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:48:37 INFO - 'download_minidump_stackwalk': True, 21:48:37 INFO - 'download_symbols': 'ondemand', 21:48:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:48:37 INFO - 'tooltool.py': '/tools/tooltool.py', 21:48:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:48:37 INFO - '/tools/misc-python/virtualenv.py')}, 21:48:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:48:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:48:37 INFO - 'gecko_profile': False, 21:48:37 INFO - 'gecko_profile_interval': 0, 21:48:37 INFO - 'installer_path': 'installer.exe', 21:48:37 INFO - 'log_level': 'info', 21:48:37 INFO - 'log_name': 'talos', 21:48:37 INFO - 'log_to_console': True, 21:48:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:48:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:48:37 INFO - 'opt_config_files': (), 21:48:37 INFO - 'pip_index': False, 21:48:37 INFO - 'suite': 'dromaeojs', 21:48:37 INFO - 'system_bits': '32', 21:48:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:48:37 INFO - 'title': 'talos-linux64-ix-037', 21:48:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:48:37 INFO - 'use_talos_json': True, 21:48:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:48:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:48:37 INFO - 'work_dir': 'build'} 21:48:37 INFO - [mozharness: 2017-04-18 04:48:37.814551Z] Running clobber step. 21:48:37 INFO - Running pre-action listener: _resource_record_pre_action 21:48:37 INFO - Running main action method: clobber 21:48:37 INFO - rmtree: /builds/slave/test/build 21:48:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:48:39 INFO - Running post-action listener: _resource_record_post_action 21:48:39 INFO - [mozharness: 2017-04-18 04:48:39.272113Z] Finished clobber step (success) 21:48:39 INFO - [mozharness: 2017-04-18 04:48:39.272212Z] Running read-buildbot-config step. 21:48:39 INFO - Running pre-action listener: _resource_record_pre_action 21:48:39 INFO - Running main action method: read_buildbot_config 21:48:39 INFO - Using buildbot properties: 21:48:39 INFO - { 21:48:39 INFO - "project": "", 21:48:39 INFO - "product": "firefox", 21:48:39 INFO - "who": "ihsiao@mozilla.com", 21:48:39 INFO - "installer_path": "public/build/target.tar.bz2", 21:48:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:48:39 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 21:48:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 21:48:39 INFO - "stage_platform": "linux64", 21:48:39 INFO - "basedir": "/builds/slave/test", 21:48:39 INFO - "buildnumber": 132, 21:48:39 INFO - "platform": "ubuntu64_hw", 21:48:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:48:39 INFO - "slavebuilddir": "test", 21:48:39 INFO - "taskId": "Ax9COhQAQkq0O9qww4gTKA", 21:48:39 INFO - "branch": "mozilla-aurora", 21:48:39 INFO - "script_repo_revision": "production", 21:48:39 INFO - "revision": "105e456d811b8c4616de688e9afdcf0af620b80b", 21:48:39 INFO - "slavename": "talos-linux64-ix-037", 21:48:39 INFO - "repo_path": "releases/mozilla-aurora" 21:48:39 INFO - } 21:48:39 INFO - Finding installer, test and symbols from parent task. 21:48:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ax9COhQAQkq0O9qww4gTKA'}, attempt #1 21:48:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ax9COhQAQkq0O9qww4gTKA'}, attempt #1 21:48:40 INFO - Task dependencies: PsEQWFcwQx-61SHySMB4TQ 21:48:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ'}, attempt #1 21:48:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.tar.bz2 21:48:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/test_packages.json 21:48:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.crashreporter-symbols.zip 21:48:40 INFO - Running post-action listener: _resource_record_post_action 21:48:40 INFO - [mozharness: 2017-04-18 04:48:40.601110Z] Finished read-buildbot-config step (success) 21:48:40 INFO - [mozharness: 2017-04-18 04:48:40.601328Z] Running download-and-extract step. 21:48:40 INFO - Running pre-action listener: _resource_record_pre_action 21:48:40 INFO - Running main action method: download_and_extract 21:48:40 INFO - mkdir: /builds/slave/test/build/tests 21:48: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')]} 21:48:40 INFO - trying https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.test_packages.json 21:48:40 INFO - Downloading https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:48:41 INFO - Downloaded 896 bytes. 21:48:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:48:41 INFO - Using the following test package requirements: 21:48:41 INFO - {u'common': [u'target.common.tests.zip'], 21:48:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:48:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:48:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:48:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:48:41 INFO - u'mozbase': [u'target.common.tests.zip'], 21:48:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:48:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:48:41 INFO - u'web-platform': [u'target.common.tests.zip', 21:48:41 INFO - u'target.web-platform.tests.zip'], 21:48:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:48:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:48:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.common.tests.zip 21:48:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:48:41 INFO - Fetch https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.common.tests.zip into memory 21:48:42 INFO - Expected file size: 59543781 21:48:42 INFO - Obtained file size: 59543781 21:48:52 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:48:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.common.tests.zip 21:48:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:48:52 INFO - Fetch https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.common.tests.zip into memory 21:48:53 INFO - Expected file size: 59543781 21:48:53 INFO - Obtained file size: 59543781 21:49:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.talos.tests.zip 21:49:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:49:03 INFO - Fetch https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.talos.tests.zip into memory 21:49:04 INFO - Expected file size: 14404424 21:49:04 INFO - Obtained file size: 14404424 21:49: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')]} 21:49:04 INFO - trying https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.tar.bz2 21:49:04 INFO - Downloading https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:49:06 INFO - Downloaded 66753829 bytes. 21:49:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.tar.bz2 21:49:06 INFO - mkdir: /builds/slave/test/properties 21:49:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:49:06 INFO - Writing to file /builds/slave/test/properties/build_url 21:49:06 INFO - Contents: 21:49:06 INFO - build_url:https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.tar.bz2 21:49:06 INFO - Running post-action listener: _resource_record_post_action 21:49:06 INFO - Running post-action listener: set_extra_try_arguments 21:49:06 INFO - [mozharness: 2017-04-18 04:49:06.063813Z] Finished download-and-extract step (success) 21:49:06 INFO - [mozharness: 2017-04-18 04:49:06.063911Z] Running populate-webroot step. 21:49:06 INFO - Running pre-action listener: _resource_record_pre_action 21:49:06 INFO - Running main action method: populate_webroot 21:49:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:49:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:49:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:49:06 INFO - '--tppagecycles', 21:49:06 INFO - '7'], 21:49:06 INFO - 'tests': ['tsvgm']}}, 21:49:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:49:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:49:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:49:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:49:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:49:06 INFO - 'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:49:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:49:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:49:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:49:06 INFO - 'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['damp', 'tps']}, 21:49:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:49:06 INFO - 'tests': ['damp', 'tps']}, 21:49:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['dromaeo_dom']}, 21:49:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:49:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['basic_compositor_video']}, 21:49:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:49:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['a11yr', 21:49:06 INFO - 'ts_paint', 21:49:06 INFO - 'tpaint', 21:49:06 INFO - 'sessionrestore', 21:49:06 INFO - 'sessionrestore_no_auto_restore', 21:49:06 INFO - 'tabpaint']}, 21:49:06 INFO - 'other-e10s': {'tests': ['a11yr', 21:49:06 INFO - 'ts_paint', 21:49:06 INFO - 'tpaint', 21:49:06 INFO - 'sessionrestore', 21:49:06 INFO - 'sessionrestore_no_auto_restore', 21:49:06 INFO - 'tabpaint']}, 21:49:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:49:06 INFO - 'ts_paint', 21:49:06 INFO - 'tpaint', 21:49:06 INFO - 'sessionrestore', 21:49:06 INFO - 'sessionrestore_no_auto_restore', 21:49:06 INFO - 'tabpaint']}, 21:49:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:49:06 INFO - 'ts_paint', 21:49:06 INFO - 'tpaint', 21:49:06 INFO - 'sessionrestore', 21:49:06 INFO - 'sessionrestore_no_auto_restore', 21:49:06 INFO - 'tabpaint']}, 21:49:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['a11yr', 21:49:06 INFO - 'ts_paint', 21:49:06 INFO - 'tpaint', 21:49:06 INFO - 'sessionrestore', 21:49:06 INFO - 'sessionrestore_no_auto_restore', 21:49:06 INFO - 'tabpaint']}, 21:49:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['a11yr', 21:49:06 INFO - 'ts_paint', 21:49:06 INFO - 'tpaint', 21:49:06 INFO - 'sessionrestore', 21:49:06 INFO - 'sessionrestore_no_auto_restore', 21:49:06 INFO - 'tabpaint']}, 21:49:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['tsvgx', 21:49:06 INFO - 'tsvgr_opacity', 21:49:06 INFO - 'tart', 21:49:06 INFO - 'tscrollx', 21:49:06 INFO - 'cart', 21:49:06 INFO - 'tsvg_static']}, 21:49:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:49:06 INFO - 'tsvgr_opacity', 21:49:06 INFO - 'tart', 21:49:06 INFO - 'tscrollx', 21:49:06 INFO - 'cart', 21:49:06 INFO - 'tsvg_static']}, 21:49:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:49:06 INFO - 'talos_options': ['--disable-e10s'], 21:49:06 INFO - 'tests': ['tp5o']}, 21:49:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:49:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:49:06 INFO - 'talos_options': ['--disable-e10s', 21:49:06 INFO - '--xperf_path', 21:49:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:49:06 INFO - 'tests': ['tp5n']}, 21:49:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:49:06 INFO - 'talos_options': ['--xperf_path', 21:49:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:49:06 INFO - 'tests': ['tp5n']}}, 21:49:06 INFO - 'talos.zip': {'path': '', 21:49:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:49:06 INFO - Running post-action listener: _resource_record_post_action 21:49:06 INFO - [mozharness: 2017-04-18 04:49:06.077177Z] Finished populate-webroot step (success) 21:49:06 INFO - [mozharness: 2017-04-18 04:49:06.077268Z] Running create-virtualenv step. 21:49:06 INFO - Running pre-action listener: _resource_record_pre_action 21:49:06 INFO - Running main action method: create_virtualenv 21:49:06 INFO - Creating virtualenv /builds/slave/test/build/venv 21:49:06 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 21:49:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:49:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:49:06 INFO - Using real prefix '/usr' 21:49:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:49:06 INFO - Installing distribute.............................................................................................................................................................................................done. 21:49:08 INFO - Installing pip.................done. 21:49:08 INFO - Return code: 0 21:49:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:49:08 INFO - Reading from file tmpfile_stdout 21:49:08 INFO - Output received: 21:49:08 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) 21:49:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:49:08 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')]} 21:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:08 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')]} 21:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:08 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 0x29de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', '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 21:49:08 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 21:49:08 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 21:49:08 INFO - Using env: {'DISPLAY': ':0', 21:49:08 INFO - 'HOME': '/home/cltbld', 21:49:08 INFO - 'LANG': 'en_US.UTF-8', 21:49:08 INFO - 'LANGUAGE': 'en_US:en', 21:49:08 INFO - 'LOGNAME': 'cltbld', 21:49:08 INFO - 'MAIL': '/var/mail/cltbld', 21:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:08 INFO - 'MOZ_NO_REMOTE': '1', 21:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:08 INFO - 'NO_EM_RESTART': '1', 21:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:08 INFO - 'PWD': '/builds/slave/test', 21:49:08 INFO - 'SHELL': '/bin/bash', 21:49:08 INFO - 'SHLVL': '1', 21:49:08 INFO - 'TERM': 'linux', 21:49:08 INFO - 'TMOUT': '86400', 21:49:08 INFO - 'USER': 'cltbld', 21:49:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:08 INFO - '_': '/tools/buildbot/bin/python'} 21:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:09 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 21:49:09 INFO - Cleaning up... 21:49:09 INFO - Return code: 0 21:49:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:49:09 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')]} 21:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:09 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')]} 21:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x29de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', '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 21:49:09 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 21:49:09 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 21:49:09 INFO - Using env: {'DISPLAY': ':0', 21:49:09 INFO - 'HOME': '/home/cltbld', 21:49:09 INFO - 'LANG': 'en_US.UTF-8', 21:49:09 INFO - 'LANGUAGE': 'en_US:en', 21:49:09 INFO - 'LOGNAME': 'cltbld', 21:49:09 INFO - 'MAIL': '/var/mail/cltbld', 21:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:09 INFO - 'MOZ_NO_REMOTE': '1', 21:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:09 INFO - 'NO_EM_RESTART': '1', 21:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:09 INFO - 'PWD': '/builds/slave/test', 21:49:09 INFO - 'SHELL': '/bin/bash', 21:49:09 INFO - 'SHLVL': '1', 21:49:09 INFO - 'TERM': 'linux', 21:49:09 INFO - 'TMOUT': '86400', 21:49:09 INFO - 'USER': 'cltbld', 21:49:09 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:09 INFO - '_': '/tools/buildbot/bin/python'} 21:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:09 INFO - Downloading/unpacking psutil>=3.1.1 21:49:09 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 21:49:09 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 21:49:09 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 21:49:09 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 21:49:09 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 21:49:09 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 21:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:49:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:49:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:49:11 INFO - Installing collected packages: psutil 21:49:11 INFO - Running setup.py install for psutil 21:49:11 INFO - building 'psutil._psutil_linux' extension 21:49:11 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 21:49:11 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 21:49:11 INFO - building 'psutil._psutil_posix' extension 21:49:11 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 21:49:11 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 21:49:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:49:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:49:11 INFO - Successfully installed psutil 21:49:11 INFO - Cleaning up... 21:49:11 INFO - Return code: 0 21:49:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:49:11 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')]} 21:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:11 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')]} 21:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:12 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 0x29de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', '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 21:49:12 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 21:49:12 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 21:49:12 INFO - Using env: {'DISPLAY': ':0', 21:49:12 INFO - 'HOME': '/home/cltbld', 21:49:12 INFO - 'LANG': 'en_US.UTF-8', 21:49:12 INFO - 'LANGUAGE': 'en_US:en', 21:49:12 INFO - 'LOGNAME': 'cltbld', 21:49:12 INFO - 'MAIL': '/var/mail/cltbld', 21:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:12 INFO - 'MOZ_NO_REMOTE': '1', 21:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:12 INFO - 'NO_EM_RESTART': '1', 21:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:12 INFO - 'PWD': '/builds/slave/test', 21:49:12 INFO - 'SHELL': '/bin/bash', 21:49:12 INFO - 'SHLVL': '1', 21:49:12 INFO - 'TERM': 'linux', 21:49:12 INFO - 'TMOUT': '86400', 21:49:12 INFO - 'USER': 'cltbld', 21:49:12 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:12 INFO - '_': '/tools/buildbot/bin/python'} 21:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:49:14 INFO - Installing collected packages: mozsystemmonitor 21:49:14 INFO - Running setup.py install for mozsystemmonitor 21:49:14 INFO - Successfully installed mozsystemmonitor 21:49:14 INFO - Cleaning up... 21:49:14 INFO - Return code: 0 21:49:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:49:14 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')]} 21:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:14 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')]} 21:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:14 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 0x29de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', '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 21:49:14 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 21:49:14 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 21:49:14 INFO - Using env: {'DISPLAY': ':0', 21:49:14 INFO - 'HOME': '/home/cltbld', 21:49:14 INFO - 'LANG': 'en_US.UTF-8', 21:49:14 INFO - 'LANGUAGE': 'en_US:en', 21:49:14 INFO - 'LOGNAME': 'cltbld', 21:49:14 INFO - 'MAIL': '/var/mail/cltbld', 21:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:14 INFO - 'MOZ_NO_REMOTE': '1', 21:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:14 INFO - 'NO_EM_RESTART': '1', 21:49:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:14 INFO - 'PWD': '/builds/slave/test', 21:49:14 INFO - 'SHELL': '/bin/bash', 21:49:14 INFO - 'SHLVL': '1', 21:49:14 INFO - 'TERM': 'linux', 21:49:14 INFO - 'TMOUT': '86400', 21:49:14 INFO - 'USER': 'cltbld', 21:49:14 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:14 INFO - '_': '/tools/buildbot/bin/python'} 21:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:14 INFO - Downloading/unpacking jsonschema==2.5.1 21:49:14 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 21:49:14 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 21:49:14 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 21:49:14 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 21:49:14 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 21:49:14 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 21:49:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:49:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:49:16 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 21:49:16 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 21:49:16 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 21:49:16 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 21:49:16 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 21:49:16 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 21:49:16 INFO - Downloading functools32-3.2.3-2.tar.gz 21:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:49:16 INFO - warning: no files found matching '*.txt' 21:49:16 INFO - no previously-included directories found matching 'build' 21:49:16 INFO - no previously-included directories found matching 'dist' 21:49:16 INFO - no previously-included directories found matching '.git*' 21:49:16 INFO - Installing collected packages: jsonschema, functools32 21:49:16 INFO - Running setup.py install for functools32 21:49:17 INFO - warning: no files found matching '*.txt' 21:49:17 INFO - no previously-included directories found matching 'build' 21:49:17 INFO - no previously-included directories found matching 'dist' 21:49:17 INFO - no previously-included directories found matching '.git*' 21:49:17 INFO - Successfully installed jsonschema functools32 21:49:17 INFO - Cleaning up... 21:49:17 INFO - Return code: 0 21:49:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:49:17 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')]} 21:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:17 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')]} 21:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:17 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 0x29de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', '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 21:49:17 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 21:49:17 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 21:49:17 INFO - Using env: {'DISPLAY': ':0', 21:49:17 INFO - 'HOME': '/home/cltbld', 21:49:17 INFO - 'LANG': 'en_US.UTF-8', 21:49:17 INFO - 'LANGUAGE': 'en_US:en', 21:49:17 INFO - 'LOGNAME': 'cltbld', 21:49:17 INFO - 'MAIL': '/var/mail/cltbld', 21:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:17 INFO - 'MOZ_NO_REMOTE': '1', 21:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:17 INFO - 'NO_EM_RESTART': '1', 21:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:17 INFO - 'PWD': '/builds/slave/test', 21:49:17 INFO - 'SHELL': '/bin/bash', 21:49:17 INFO - 'SHLVL': '1', 21:49:17 INFO - 'TERM': 'linux', 21:49:17 INFO - 'TMOUT': '86400', 21:49:17 INFO - 'USER': 'cltbld', 21:49:17 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:17 INFO - '_': '/tools/buildbot/bin/python'} 21:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:49:17 INFO - Cleaning up... 21:49:17 INFO - Return code: 0 21:49:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:49:17 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')]} 21:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:17 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')]} 21:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:17 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 0x29de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', '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 21:49:17 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 21:49:17 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 21:49:17 INFO - Using env: {'DISPLAY': ':0', 21:49:17 INFO - 'HOME': '/home/cltbld', 21:49:17 INFO - 'LANG': 'en_US.UTF-8', 21:49:17 INFO - 'LANGUAGE': 'en_US:en', 21:49:17 INFO - 'LOGNAME': 'cltbld', 21:49:17 INFO - 'MAIL': '/var/mail/cltbld', 21:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:17 INFO - 'MOZ_NO_REMOTE': '1', 21:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:17 INFO - 'NO_EM_RESTART': '1', 21:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:17 INFO - 'PWD': '/builds/slave/test', 21:49:17 INFO - 'SHELL': '/bin/bash', 21:49:17 INFO - 'SHLVL': '1', 21:49:17 INFO - 'TERM': 'linux', 21:49:17 INFO - 'TMOUT': '86400', 21:49:17 INFO - 'USER': 'cltbld', 21:49:17 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:17 INFO - '_': '/tools/buildbot/bin/python'} 21:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:17 INFO - Downloading/unpacking blobuploader==1.2.4 21:49:17 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 21:49:17 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 21:49:17 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 21:49:17 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 21:49:17 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 21:49:17 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 21:49:19 INFO - Downloading blobuploader-1.2.4.tar.gz 21:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:49:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:49:19 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 21:49:19 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 21:49:19 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 21:49:19 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 21:49:19 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 21:49:19 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 21:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:49:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:49:20 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 21:49:20 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 21:49:20 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 21:49:20 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 21:49:20 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 21:49:20 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 21:49:20 INFO - Downloading docopt-0.6.1.tar.gz 21:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:49:20 INFO - Installing collected packages: blobuploader, requests, docopt 21:49:20 INFO - Running setup.py install for blobuploader 21:49:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:49:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:49:20 INFO - Running setup.py install for requests 21:49:20 INFO - Running setup.py install for docopt 21:49:20 INFO - Successfully installed blobuploader requests docopt 21:49:20 INFO - Cleaning up... 21:49:20 INFO - Return code: 0 21:49:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49:20 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')]} 21:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:20 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')]} 21:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:20 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 0x29de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', '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 21:49:20 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 21:49:20 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 21:49:20 INFO - Using env: {'DISPLAY': ':0', 21:49:20 INFO - 'HOME': '/home/cltbld', 21:49:20 INFO - 'LANG': 'en_US.UTF-8', 21:49:20 INFO - 'LANGUAGE': 'en_US:en', 21:49:20 INFO - 'LOGNAME': 'cltbld', 21:49:20 INFO - 'MAIL': '/var/mail/cltbld', 21:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:20 INFO - 'MOZ_NO_REMOTE': '1', 21:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:20 INFO - 'NO_EM_RESTART': '1', 21:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:20 INFO - 'PWD': '/builds/slave/test', 21:49:20 INFO - 'SHELL': '/bin/bash', 21:49:20 INFO - 'SHLVL': '1', 21:49:20 INFO - 'TERM': 'linux', 21:49:20 INFO - 'TMOUT': '86400', 21:49:20 INFO - 'USER': 'cltbld', 21:49:20 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:20 INFO - '_': '/tools/buildbot/bin/python'} 21:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:49:21 INFO - Running setup.py (path:/tmp/pip-sKCyTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:49:21 INFO - Running setup.py (path:/tmp/pip-exY0jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:49:21 INFO - Running setup.py (path:/tmp/pip-auZrmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:49:21 INFO - Running setup.py (path:/tmp/pip-kRQtSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:49:21 INFO - Running setup.py (path:/tmp/pip-JZ9NKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:49:21 INFO - Running setup.py (path:/tmp/pip-5G4t6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:49:21 INFO - Running setup.py (path:/tmp/pip-NMWw5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:49:21 INFO - Running setup.py (path:/tmp/pip-kOfVi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:49:21 INFO - Running setup.py (path:/tmp/pip-GAbu3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:49:21 INFO - Running setup.py (path:/tmp/pip-XDaYJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:49:21 INFO - Running setup.py (path:/tmp/pip-eWOwSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:49:22 INFO - Running setup.py (path:/tmp/pip-CprpW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:49:22 INFO - Running setup.py (path:/tmp/pip-umeuNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:49:22 INFO - Running setup.py (path:/tmp/pip-t8Vf6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:22 INFO - Running setup.py (path:/tmp/pip-6kidKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:49:22 INFO - Running setup.py (path:/tmp/pip-mBKeGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:49:22 INFO - Running setup.py (path:/tmp/pip-1Tsumu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:49:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:49:22 INFO - Running setup.py install for manifestparser 21:49:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:49:22 INFO - Running setup.py install for mozcrash 21:49:22 INFO - Running setup.py install for mozdebug 21:49:22 INFO - Running setup.py install for mozdevice 21:49:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:49:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:49:22 INFO - Running setup.py install for mozfile 21:49:22 INFO - Running setup.py install for mozhttpd 21:49:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Running setup.py install for mozinfo 21:49:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Running setup.py install for mozInstall 21:49:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Running setup.py install for mozleak 21:49:23 INFO - Running setup.py install for mozlog 21:49:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Running setup.py install for moznetwork 21:49:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Running setup.py install for mozprocess 21:49:23 INFO - Running setup.py install for mozprofile 21:49:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Running setup.py install for mozrunner 21:49:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:49:23 INFO - Running setup.py install for mozscreenshot 21:49:24 INFO - Running setup.py install for moztest 21:49:24 INFO - Running setup.py install for mozversion 21:49:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:49:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:49:24 INFO - Cleaning up... 21:49:24 INFO - Return code: 0 21:49:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:24 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 0x29de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', '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 21:49:24 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 21:49:24 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 21:49:24 INFO - Using env: {'DISPLAY': ':0', 21:49:24 INFO - 'HOME': '/home/cltbld', 21:49:24 INFO - 'LANG': 'en_US.UTF-8', 21:49:24 INFO - 'LANGUAGE': 'en_US:en', 21:49:24 INFO - 'LOGNAME': 'cltbld', 21:49:24 INFO - 'MAIL': '/var/mail/cltbld', 21:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:24 INFO - 'MOZ_NO_REMOTE': '1', 21:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:24 INFO - 'NO_EM_RESTART': '1', 21:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:24 INFO - 'PWD': '/builds/slave/test', 21:49:24 INFO - 'SHELL': '/bin/bash', 21:49:24 INFO - 'SHLVL': '1', 21:49:24 INFO - 'TERM': 'linux', 21:49:24 INFO - 'TMOUT': '86400', 21:49:24 INFO - 'USER': 'cltbld', 21:49:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:24 INFO - '_': '/tools/buildbot/bin/python'} 21:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:49:24 INFO - Running setup.py (path:/tmp/pip-pICUC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:49:24 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)) 21:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:49:24 INFO - Running setup.py (path:/tmp/pip-5bQZgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:49:24 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)) 21:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:49:24 INFO - Running setup.py (path:/tmp/pip-A70wHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:49:24 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)) 21:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:49:24 INFO - Running setup.py (path:/tmp/pip-bdLRG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:49:24 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)) 21:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:49:24 INFO - Running setup.py (path:/tmp/pip-qCT24l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:49:24 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)) 21:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:49:24 INFO - Running setup.py (path:/tmp/pip-d8nxGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:49:24 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)) 21:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:49:24 INFO - Running setup.py (path:/tmp/pip-jQv4CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:49:24 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)) 21:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:49:24 INFO - Running setup.py (path:/tmp/pip-eNTitN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:49:25 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)) 21:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:49:25 INFO - Running setup.py (path:/tmp/pip-VtMZp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:49:25 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)) 21:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:49:25 INFO - Running setup.py (path:/tmp/pip-DRsPG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:49:25 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)) 21:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:49:25 INFO - Running setup.py (path:/tmp/pip-LQ4BRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:49:25 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)) 21:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:49:25 INFO - Running setup.py (path:/tmp/pip-ws1pSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:49:25 INFO - Running setup.py (path:/tmp/pip-G_PUcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:49:25 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)) 21:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:49:25 INFO - Running setup.py (path:/tmp/pip-9u2UwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:49:25 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)) 21:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:25 INFO - Running setup.py (path:/tmp/pip-eotZLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:25 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)) 21:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:49:25 INFO - Running setup.py (path:/tmp/pip-XdNrcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:49:25 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)) 21:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:49:25 INFO - Running setup.py (path:/tmp/pip-29lwfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:49:25 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)) 21:49:25 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)) 21:49:25 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)) 21:49:25 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)) 21:49:25 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)) 21:49:25 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)) 21:49:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:27 INFO - Downloading blessings-1.6.tar.gz 21:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:49:27 INFO - Installing collected packages: blessings 21:49:27 INFO - Running setup.py install for blessings 21:49:27 INFO - Successfully installed blessings 21:49:27 INFO - Cleaning up... 21:49:28 INFO - Return code: 0 21:49:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:49:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:49:28 INFO - Reading from file tmpfile_stdout 21:49:28 INFO - Current package versions: 21:49:28 INFO - argparse == 1.2.1 21:49:28 INFO - blessings == 1.6 21:49:28 INFO - blobuploader == 1.2.4 21:49:28 INFO - docopt == 0.6.1 21:49:28 INFO - functools32 == 3.2.3-2 21:49:28 INFO - jsonschema == 2.5.1 21:49:28 INFO - manifestparser == 1.1 21:49:28 INFO - mozInstall == 1.12 21:49:28 INFO - mozcrash == 1.0 21:49:28 INFO - mozdebug == 0.1 21:49:28 INFO - mozdevice == 0.49 21:49:28 INFO - mozfile == 1.2 21:49:28 INFO - mozhttpd == 0.7 21:49:28 INFO - mozinfo == 0.9 21:49:28 INFO - mozleak == 0.1 21:49:28 INFO - mozlog == 3.4 21:49:28 INFO - moznetwork == 0.27 21:49:28 INFO - mozprocess == 0.25 21:49:28 INFO - mozprofile == 0.28 21:49:28 INFO - mozrunner == 6.13 21:49:28 INFO - mozscreenshot == 0.1 21:49:28 INFO - mozsystemmonitor == 0.3 21:49:28 INFO - moztest == 0.8 21:49:28 INFO - mozversion == 1.4 21:49:28 INFO - psutil == 3.1.1 21:49:28 INFO - requests == 1.2.3 21:49:28 INFO - wsgiref == 0.1.2 21:49:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:28 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 0x29de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', '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 21:49:28 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 21:49:28 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 21:49:28 INFO - Using env: {'DISPLAY': ':0', 21:49:28 INFO - 'HOME': '/home/cltbld', 21:49:28 INFO - 'LANG': 'en_US.UTF-8', 21:49:28 INFO - 'LANGUAGE': 'en_US:en', 21:49:28 INFO - 'LOGNAME': 'cltbld', 21:49:28 INFO - 'MAIL': '/var/mail/cltbld', 21:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:28 INFO - 'MOZ_NO_REMOTE': '1', 21:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:28 INFO - 'NO_EM_RESTART': '1', 21:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:28 INFO - 'PWD': '/builds/slave/test', 21:49:28 INFO - 'SHELL': '/bin/bash', 21:49:28 INFO - 'SHLVL': '1', 21:49:28 INFO - 'TERM': 'linux', 21:49:28 INFO - 'TMOUT': '86400', 21:49:28 INFO - 'USER': 'cltbld', 21:49:28 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:28 INFO - '_': '/tools/buildbot/bin/python'} 21:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:28 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)) 21:49:28 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)) 21:49:28 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)) 21:49:28 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)) 21:49:28 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)) 21:49:28 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)) 21:49:28 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)) 21:49:28 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)) 21:49:28 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)) 21:49:28 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)) 21:49:28 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)) 21:49:28 INFO - Cleaning up... 21:49:28 INFO - Return code: 0 21:49:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', '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 21:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:49:28 INFO - Using env: {'DISPLAY': ':0', 21:49:28 INFO - 'HOME': '/home/cltbld', 21:49:28 INFO - 'LANG': 'en_US.UTF-8', 21:49:28 INFO - 'LANGUAGE': 'en_US:en', 21:49:28 INFO - 'LOGNAME': 'cltbld', 21:49:28 INFO - 'MAIL': '/var/mail/cltbld', 21:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:28 INFO - 'MOZ_NO_REMOTE': '1', 21:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:28 INFO - 'NO_EM_RESTART': '1', 21:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:28 INFO - 'PWD': '/builds/slave/test', 21:49:28 INFO - 'SHELL': '/bin/bash', 21:49:28 INFO - 'SHLVL': '1', 21:49:28 INFO - 'TERM': 'linux', 21:49:28 INFO - 'TMOUT': '86400', 21:49:28 INFO - 'USER': 'cltbld', 21:49:28 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:28 INFO - '_': '/tools/buildbot/bin/python'} 21:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:49:28 INFO - Cleaning up... 21:49:28 INFO - Return code: 0 21:49:28 INFO - Running post-action listener: _resource_record_post_action 21:49:28 INFO - Running post-action listener: _start_resource_monitoring 21:49:28 INFO - Starting resource monitoring. 21:49:28 INFO - [mozharness: 2017-04-18 04:49:28.729083Z] Finished create-virtualenv step (success) 21:49:28 INFO - [mozharness: 2017-04-18 04:49:28.729588Z] Running install step. 21:49:28 INFO - Running pre-action listener: _resource_record_pre_action 21:49:28 INFO - Running main action method: install 21:49:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:49:28 INFO - Reading from file tmpfile_stdout 21:49:28 INFO - Detecting whether we're running mozinstall >=1.0... 21:49:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:49:29 INFO - Reading from file tmpfile_stdout 21:49:29 INFO - Output received: 21:49:29 INFO - Usage: mozinstall [options] installer 21:49:29 INFO - Options: 21:49:29 INFO - -h, --help show this help message and exit 21:49:29 INFO - -d DEST, --destination=DEST 21:49:29 INFO - Directory to install application into. [default: 21:49:29 INFO - "/builds/slave/test"] 21:49:29 INFO - --app=APP Application being installed. [default: firefox] 21:49:29 INFO - mkdir: /builds/slave/test/build/application 21:49:29 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'] 21:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:49:45 INFO - Reading from file tmpfile_stdout 21:49:45 INFO - Output received: 21:49:45 INFO - /builds/slave/test/build/application/firefox/firefox 21:49:45 INFO - Running post-action listener: _resource_record_post_action 21:49:45 INFO - [mozharness: 2017-04-18 04:49:45.698709Z] Finished install step (success) 21:49:45 INFO - [mozharness: 2017-04-18 04:49:45.698941Z] Running run-tests step. 21:49:45 INFO - Running pre-action listener: _resource_record_pre_action 21:49:45 INFO - Running main action method: run_tests 21:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:49:45 INFO - Python 2.7.3 21:49:45 INFO - Return code: 0 21:49:45 INFO - grabbing minidump binary from tooltool 21:49: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')]} 21:49:45 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 0x2c79400>, '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 0x2c7a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:49:45 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 21:49:45 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 21:49:45 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 21:49:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:49:45 INFO - Return code: 0 21:49:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:49:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:49:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:49:45 INFO - ENV: RUST_BACKTRACE is now 1 21:49:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:49:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:49:45 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/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 21:49:45 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/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 21:49:45 INFO - Using env: {'DISPLAY': ':0', 21:49:45 INFO - 'HOME': '/home/cltbld', 21:49:45 INFO - 'LANG': 'en_US.UTF-8', 21:49:45 INFO - 'LANGUAGE': 'en_US:en', 21:49:45 INFO - 'LOGNAME': 'cltbld', 21:49:45 INFO - 'MAIL': '/var/mail/cltbld', 21:49:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:49:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:45 INFO - 'MOZ_NO_REMOTE': '1', 21:49:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:45 INFO - 'NO_EM_RESTART': '1', 21:49:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:45 INFO - 'PWD': '/builds/slave/test', 21:49:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:49:45 INFO - 'RUST_BACKTRACE': '1', 21:49:45 INFO - 'SHELL': '/bin/bash', 21:49:45 INFO - 'SHLVL': '1', 21:49:45 INFO - 'TERM': 'linux', 21:49:45 INFO - 'TMOUT': '86400', 21:49:45 INFO - 'USER': 'cltbld', 21:49:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508', 21:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:45 INFO - '_': '/tools/buildbot/bin/python'} 21:49:45 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/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 21:49:45 INFO - mozversion application_buildid: 20170418035801 21:49:45 INFO - mozversion application_changeset: 105e456d811b8c4616de688e9afdcf0af620b80b 21:49:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:49:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:49:45 INFO - mozversion application_name: Firefox 21:49:45 INFO - mozversion application_remotingname: firefox-dev 21:49:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:49:45 INFO - mozversion application_vendor: Mozilla 21:49:45 INFO - mozversion application_version: 54.0a2 21:49:45 INFO - mozversion platform_buildid: 20170418035801 21:49:45 INFO - mozversion platform_changeset: 105e456d811b8c4616de688e9afdcf0af620b80b 21:49:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:49:45 INFO - mozversion platform_version: 54.0a2 21:49:45 INFO - using testdate: 1492490985 21:49:45 INFO - actual date: 1492490985 21:49:45 INFO - starting webserver on 'localhost:55520' 21:49:45 INFO - SUITE-START | Running 2 tests 21:49:45 INFO - TEST-START | dromaeo_css 21:49:45 INFO - operating with platform_type : linux_ 21:49:45 INFO - Initialising browser for dromaeo_css test... 21:49:46 INFO - TEST-INFO | started process 30221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1F_Lic/profile http://localhost:55520/getInfo.html) 21:49:50 INFO - PROCESS | 30221 | __metrics Screen width/height:1600/1200 21:49:50 INFO - PROCESS | 30221 | colorDepth:24 21:49:50 INFO - PROCESS | 30221 | Browser inner width/height: 1024/697 21:49:50 INFO - PROCESS | 30221 | __metrics 21:49:51 INFO - PROCESS | 30221 | 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" 21:49:51 INFO - PROCESS | 30221 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:49:52 INFO - TEST-INFO | 30221: exit 0 21:49:52 INFO - Browser initialized. 21:49:52 INFO - Running cycle 1/1 for dromaeo_css test... 21:49:52 INFO - TEST-INFO | started process 30313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1F_Lic/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:50:04 INFO - PROCESS | 30313 | RSS: Main: 139902976 21:50:04 INFO - PROCESS | 30313 | 21:53:06 INFO - PROCESS | 30313 | Cycle 1(1): loaded http://localhost:55520/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55520/tests/dromaeo/cssquery-ext.html) 21:53:07 INFO - PROCESS | 30313 | RSS: Main: 281800704 21:53:07 INFO - PROCESS | 30313 | 21:54:54 INFO - PROCESS | 30313 | ************************* 21:54:54 INFO - PROCESS | 30313 | A coding exception was thrown and uncaught in a Task. 21:54:54 INFO - PROCESS | 30313 | 21:54:54 ERROR - PROCESS | 30313 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:54:54 INFO - PROCESS | 30313 | Full stack: 21:54:54 INFO - PROCESS | 30313 | ************************* 21:54:54 INFO - PROCESS | 30313 | ************************* 21:54:54 INFO - PROCESS | 30313 | A coding exception was thrown and uncaught in a Task. 21:54:54 INFO - PROCESS | 30313 | 21:54:54 ERROR - PROCESS | 30313 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:54:54 INFO - PROCESS | 30313 | Full stack: 21:54:54 INFO - PROCESS | 30313 | ************************* 21:54:54 INFO - PROCESS | 30313 | ************************* 21:54:54 INFO - PROCESS | 30313 | A coding exception was thrown and uncaught in a Task. 21:54:54 INFO - PROCESS | 30313 | 21:54:54 ERROR - PROCESS | 30313 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:54:54 INFO - PROCESS | 30313 | Full stack: 21:54:54 INFO - PROCESS | 30313 | ************************* 21:54:54 INFO - PROCESS | 30313 | ************************* 21:54:54 INFO - PROCESS | 30313 | A coding exception was thrown and uncaught in a Task. 21:54:54 INFO - PROCESS | 30313 | 21:54:54 ERROR - PROCESS | 30313 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:54:54 INFO - PROCESS | 30313 | Full stack: 21:54:54 INFO - PROCESS | 30313 | ************************* 21:56:09 INFO - PROCESS | 30313 | Cycle 1(1): loaded http://localhost:55520/tests/dromaeo/cssquery-ext.html (next: http://localhost:55520/tests/dromaeo/cssquery-jquery.html) 21:56:10 INFO - PROCESS | 30313 | RSS: Main: 215617536 21:56:10 INFO - PROCESS | 30313 | 21:59:12 INFO - PROCESS | 30313 | Cycle 1(1): loaded http://localhost:55520/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55520/tests/dromaeo/cssquery-mootools.html) 21:59:12 INFO - PROCESS | 30313 | RSS: Main: 209850368 21:59:12 INFO - PROCESS | 30313 | 22:02:14 INFO - PROCESS | 30313 | Cycle 1(1): loaded http://localhost:55520/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55520/tests/dromaeo/cssquery-prototype.html) 22:02:15 INFO - PROCESS | 30313 | RSS: Main: 170844160 22:02:15 INFO - PROCESS | 30313 | 22:05:18 INFO - PROCESS | 30313 | Cycle 1(1): loaded http://localhost:55520/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55520/tests/dromaeo/cssquery-yui.html) 22:05:18 INFO - PROCESS | 30313 | RSS: Main: 175370240 22:05:18 INFO - PROCESS | 30313 | 22:08:21 INFO - PROCESS | 30313 | Cycle 1(1): loaded http://localhost:55520/tests/dromaeo/cssquery-yui.html (next: http://localhost:55520/tests/dromaeo/cssquery-dojo.html) 22:08:21 INFO - PROCESS | 30313 | RSS: Main: 265777152 22:08:21 INFO - PROCESS | 30313 | 22:08:21 INFO - PROCESS | 30313 | __start_tp_report 22:08:21 INFO - PROCESS | 30313 | _x_x_mozilla_page_load 22:08:21 INFO - PROCESS | 30313 | _x_x_mozilla_page_load_details 22:08:21 INFO - PROCESS | 30313 | |i|pagename|runs| 22:08:21 INFO - PROCESS | 30313 | |0;dojo.html;3337.5327454156413;3372.2412457197133;3398.371301309257;3421.760476766627;3446.2245994651207;5690.9715451422735;5766.077427611583;5796;5808.273965754281;5819.825405237839;5793.7103144842695;5830.242068531085;5846.590738648296;5852.648841069539;5858.677772722499;5252.395974462938;5273.393559740641;5285.6300058995885;5285.735713214343;5368.516833484986;5115.565176959963;5115.795368185268;5362.249285100089;5377.516023557879;5378.085725426687;5220.738963051832;5222.63441559091;5316.9734151329185;5326.573874090063;5350.892982140354;5342.412334643186;5344.599155063347;5345.7594408251525;5353.973230133864;5356.651817631841;5064.468230835783;5205.479452054764;5262.736863156827;5315.946840531584;5324.1215199492035;5594.468525490072;5620.690862002588;5627.324721033461;5688.914666279968;5712.714364281769;6150.84622884427;6179.938200617981;6180.536459765535;6187.412195841388;6192.287886892975;6180.598261113013;6214.161088253073;6229.345918678564;6237.812865614039;6249.843753906143;5636.464535869127;5651.32184137902;5740.626859254176;5779.508741756914;5780.21967034445;6348.460380867678;6348.650824204621;6353.777617783356;6353.809385718436;6354.555181137276;6035.8792824143275;6118.6022908511695;6120.785772497941;6123.326434092335;6136.325004249529;5940.34656187819;5970.31341395745;6125.845966769368;6140.969295153495;6211.130441738161;6188.938110618927;6202.968985155046;6207.193064901534;6208.937910620836;6209.6895155242055;5975.163477113208;6016.879662406727;6022.969885150546;6122.908156377658;6209.223847019122;4692.085043416501;4730.62155027597;4744.383230180055;4753;4757.14371413142;4088.2232375848494;4089.754614723126;4172.666186705056;4242.4272723181975;4253.553376895444;5948.10778383246;6019.939800601938;6036.849078773066;6040.7583696651645;6047.2743270806905;6241.812745617639;6272.937270627326;6275.592086514362;6279.152314437584;6290.056491526308;5658.122990936411;6034.969825150846;6038.698065096728;6050.909236361458;6080.513558915276;5131.204663277198;5199.584033277329;5236.083685355047;5287.973560132252;5297.894042119136;6487.708053137526;6524.64114473699;6526.347365263436;6531.183602049839;6532.08550802888;6178.351273116438;6194.907076393948;6232.906506402317;6243.250809902841;6243.344448832807;6270.996640537492;6300.432961033345;6415.1981002374705;6433.967830160819;6536.248331441945;6163.414475624809;6164.075388691732;6164.47601953839;6168.25980882297;6173.382661733791;6274.435300822948;6276.340984196776;6280.403361680633;6280.5289603279025;6286.18279623646;5719.685417302088;5888.087346461305;5943.970280148572;6014.428629280212;6117.1130186123655;6083.574149809471;6103.69481525913;6107.969460152671;6109.877802444015;6144.6620435874665;6057.454829065406;6066.393360664075;6089.634621922699;6091.7258723358445;6094.573379863367;5875.412458754261;5895.823125306248;5946.643201407756;6043.12374705674;6073.726682299395;6009.278886533644;6033.577649564664;6037.758489660365;6058.303295121117;6058.848528786815 22:08:21 INFO - PROCESS | 30313 | |1;ext.html;783.9608019599019;839.9790005249868;859.9183077607627;914.5472990869521;921.1847514949276;30993.225169370777;43402.131957360834;43564.78217608915;43650.563494365044;43689.126217475634;40384.39423408651;40535.79732101343;40632.593674063326;45821.08357832841;45939.31091033629;7630.961845190766;8712.390132690714;8841.911580884173;8842.778930526756;8851.601677924476;7634.312911837934;7709;7712;7716.7684969451;10453.947730261376;10802.081823045051;10824.079953203987;10825.24223304369;10831.566737330537;10837.512311945942;10714.892851071467;10733;10733.302335348217;10733.838992415082;10749.408782516959;10450.320729152656;10513.053825155695;10524.052835244787;10529.262951593391;10536.157107431387;41404.585954140675;41462;41540.1691966162;41566.79216603928;41639.583604164174;4200.831966721327;4265.573442655741;4286.57134286572;4362.47650281965;4370.8033138508845;29266.414671706658;29624.111276661733;29662.258443538867;30083.69916300853;30796;4326.480822301344;4397.824087036547;4406.625436837872;4414.183376075404;4500;222214;222838.88580557157;223034;223040;223137;53636.46363536393;53727.73136134294;53755.46244537583;53769.1934620981;53847;56103.15845262324;56487.43512564904;56591.71704141453;56916;56987.430125699044;14938;15115.168665723491;15131.092134471966;15134.545963621109;15139.318730657147;12953;12976.286304253168;13000.739985200244;13001.609951701465;13004.024698147678;12070.517179312905;12228.082893783001;13313.40089695966;13871.514496992557;13933.442662293597;5517.862053448615;5526.917096243559;5624.606277560531;5634.915476267859;5651.095824668116;962.4562122400821;962.6582563190107;966.5167416291854;967.8499832525829;975.6487664440796;26572.734272657413;28321;28506.85746571254;28608.856955715088;28688.13935581936;1055.0188324857802;1066.0405634928472;1077.3643550305358;1081.124289325633;1133.8752737198902;15420.306086226146;16883.91558042202;17250.913745431193;17469.30122795074;17557.034363110153;336111;337469;337736;339009;340799;60112.39887601155;60277.39722602806;60367.094493582634;60457;60582.69708651429;1514.6289159155856;1553.1672626300847;1576.4955214331533;1581.1777875504672;1584.5088022712996;30229.244268892573;31299.37401252008;31319;31756.206094847814;31851.20371990719;42599.361009585504;45911;46651.76674116608;52523.474765251856;52724;333771;334390;335015;337175;337559;33333;33363.66636333606;33372.49941250835;33530;33811;34104.829475852464;40406.1918761629;43343.56656433395;43702.56297436985;44029.77985110182;30233.395332093674;30830.84584577063;31505;31922.20194495156;31964.200894976882;31782.205444864063;31819.84090079535;31825.04524864258;32124;32381.838090809397;36349.27301454009;36384.818075909454;36587.26825463529;36770;37227.441588376736;29711.55432668555;30159.396812064075;30921.381572367976;31031.224219393793;31057.844710776302;25985.870070649526;26274.737252627994;26417.207483775517;26481.602775957992;26839.597406039316 22:08:21 INFO - PROCESS | 30313 | |2;jquery.html;409.1816367265469;465.71824046451906;469.47653366496365;484.0464285357845;484.215570775344;18978.71531927022;19956;20553.69169462459;20658;20687.069081891314;21557.892210538965;22032.669509957363;22189.556208875812;22390.776092239113;22587;6195.2255968004;6326.715297811586;6520.0871877937125;6574.737010519573;6602.075709400664;6355.68221588921;6679.599224046548;6682.231543372526;6685.4985876059245;6686.799396018103;6384.680765961683;6597.967010164966;6642.5350225484235;6679.966600166992;6691.498137639672;6374.776882809079;6609;6662.833429164285;6665.866682666368;6672.666366681695;6432.421082102634;6440.806775796734;6477.481801455872;6484;6484.383983521605;24914.750852491423;25015.374615634573;25085.122020729188;25106.12128575491;25278.620820687705;3095.9535606965915;3153.353562519678;3154.8422578870964;3157.8263195524237;3202.071399294202;16318.673626527521;16343.83656163435;16527.752083718755;16597;16623.41818036375;2269.693591365161;2318.385627808632;2341.30931375243;2362.8464149830206;2382.4401265702545;88303;88965;89445.55277223638;91387;91703.54148229283;14729.779053314209;17670.674699397598;18653.720194197096;19511.902440487705;19789.60420791576;27028.59457108145;28147.296317592223;36460;36515.26969460596;36548.45177322342;9829.55766990487;9857;9900.851487227554;9929.602815887429;10074.69775906724;8310.168983101763;8346;8363.665453381796;8526.104759000216;8542.615582298811;9004.41471304363;9175.54122293896;9175.862362064574;9383.906160938439;9420.905790942003;3829.5787463379006;3935.2916475034194;3949.3878448840474;3974.025974025974;4004.0570180917002;942.4533770413144;944.1125342178331;948.170350942925;963.3352986439335;964.4068897627908;19841.702374464105;20188.192472300943;21218.514703970573;21543.56912861734;21552.56894862094;973.4694591447678;1068.893110688925;1114.6878873915316;1124.2748427264369;1138.9772204555863;10861.239713219999;11456.828147577793;11499.482523286471;11527.827082593767;11535;682065;719451;720457;740196;750416;121311.39344303223;125833.37083314525;126141;127776;130122;1335.125492802216;1353.2489468344966;1376.4769387632837;1395.1907893421792;1403.9929800350933;14377.712445750818;18429.26282948667;19352.70970935465;19598.706019409434;19760.90119549393;52253.216201757765;52629.7368513155;53096.73451632872;53486;54768;66350.66824665846;66596;66718.33281667315;67514;67711.66144169247;12635.305058221886;12711.237325760483;12756.744865102832;12783.977281817246;12874.67813304675;14083.084599501;14111.153330800185;14208.07647502909;14298.428062877785;14343.497977570734;12314.568990085305;12421.75156496883;12447.439865205906;12464.376781160725;12631.431585578855;11424.428778560872;11432.428378581204;11634.6509604712;11749.177557570887;11816.172867899508;12342.382880856101;12599.811002834782;12850.293233872228;12884.291363975071;13343.199408035549;14784.852151478777;14810.777838332218;14905.701885962437;14939.701205976036;15026.699466010838;13719.176849389069;13873.791893121814;13999.230042347768;14103.2948352584;14181.503647372705 22:08:21 INFO - PROCESS | 30313 | |3;mootools.html;1534.9232538373078;1540.8767298616112;1558.2831897327235;1564.1162743050177;1590.8568228859401;10766.838497422545;11493.425328733561;11498.942505287483;11499.19505634606;11508.30950142992;10379.896201037987;10597.682069537907;10620.309679870803;10624.57501699933;11241;2316.281952594697;2330.149495434163;2355.0697474497565;2360.8701521416315;2360.988195059031;2334.48641298914;2369.099742098;2481.6029435290357;2481.8759062046915;2486.9005239790386;2385.0340612052146;2406.9638955415685;2411.6623672685837;2473.480569080495;2481.5781317176034;2301.344116926685;2312.1329501436962;2404.8677322747244;2411.2163546847255;2418.4558474343307;2378.8691621960784;2387.164492427654;2401.8078553715836;2409.084547871815;2411.071737381121;11285.830712539318;11430.771384572345;11461.36962467064;11467.279908013781;11483.885161148366;5731.083026715747;5840.912386314209;5867.266591676041;5880.882382352372;5882.764689412418;3491.91270218244;3573.5890372606964;3573.982130089359;3631.7276204284785;3635.63643635637;1330.7072444062292;1385.757492438819;1398.1191849135082;1409.2953523238382;1477.5862758427656;16287;16579;16622.25199865997;16662.333506659717;16730.581735456588;4670.15528866096;4751.786169622375;4858.878528036827;4859.684120532154;4885.853424397274;13000.219986800823;13010.284434356012;13015.869841301655;13020.088593798344;13028.08803383773;5965.343812180657;5974.4324289192455;5974.970125149346;5977.641341519523;5983.521318294613;5214.765335559909;5470.179473078991;5512.972435137799;5513.062779327524;5546.584006199551;3933.3116704576582;4041.6766658667234;4081.3265811140827;4115.259253334429;4152.190322887069;1091.3615534912165;1093.7211011192255;1095.134843473647;1104.9447527623747;1108.4734750993375;1021.5760459409262;1025.3898930136556;1035.8705161854768;1042.3537406807827;1046.1264843855313;6692.96653516739;6821.3519715626935;6848.486363522756;6908.516403851782;6940.514164008572;1030.907218350352;1048.5910494906993;1056.709404913655;1082.4533610526635;1101.1906248907046;4493.6854420190275;4584.610308123847;4609.516000819933;4671.579557839811;4697;14031.298435078204;14687.485937992118;14706;14729.852701472848;14761.852381476263;12052.879471205175;14603.78094328586;14622.488212912496;14653.853461465249;14658.560243192722;8575.914240857637;9392.154706076486;9522.047795220422;9538;9595.616175352907;7092.326229008236;7127.928720712934;7257.673404696696;7305.305995930378;7321.377682897013;12165.148439609142;12274.386280686109;12285.754284914074;12348.506059757508;12450.941669958154;12609.369531523571;12633.747325053631;12655.87344126547;12711.110222284722;12871.292078935749;8802.471851688919;8941.37410381267;8976.28189744832;8988.955055224682;8995.23540499065;10352;10360.222983276435;10384.896151038392;10415.635452759117;10485.161187105166;8947.910520894708;9011.369204155646;9025.458472491671;9063.184313411824;9241.168294853496;8916.509591972504;8977.955110224408;9011.729648110306;9023.90976090257;9131.680391186543;8013.318867896294;8122.472039317426;8181.263686268265;8184.508929464251;8193.262606365217;6103.42017508336;6192.040233763774;6193.473554747897;6238.6880655967925;6341.682915854097;5895.7052147391605;5964.9105263420215;6025.307089684742;6099.359567245376;6173.38266173397 22:08:21 INFO - PROCESS | 30313 | |4;prototype.html;424.1897974868003;433.8871893307739;436.4304582519812;439.9846005389812;441.96022357987795;5157.638965272433;5216.973915130419;5219.660722053064;5263.868403289915;5286.281958363537;5061.6709913855575;5071.087204303224;5095.847124586259;5121.308623335848;5127.179651255799;4334.3498475228735;4370.519242883281;4402;4407.047278323515;4413;4349.478062632488;4363.149185908749;4377.562243775629;4389.4513185851765;4397.6587140922;4336.7181133226395;4346.804393802271;4356.368326592642;4365.3233748768835;4390.297552391618;4149.211649786531;4284.5715428457215;4353.62994145498;4360.607545320936;4459.331100334944;4088.509378874554;4095.464200924653;4101.26177288088;4110.568390319033;4129.752214867118;5023.623228257895;5023.748812559357;5030.597552195853;5054.873628159288;5075.543201111881;4887.902241955141;4981.526754958273;4998.450170481244;5067.949320506785;5072.340595722532;5363.115086010804;5369.691032855871;5371.489708477728;5381.865453363658;5394.703291318976;4522.819087236507;4536.684361535151;4545.2954792007295;4560.703554268962;4579.992401671627;5350;5581.6836013054935;5609.9145469991345;5619.145681924996;5622.971885140548;4653.464851542049;4653.976730116327;4657.231556793159;4663.813447462064;4665.930011049837;4750.881227969259;4792.257200133985;4793.352897358882;4797.736124513185;4800.5199480051715;4794.50349754794;4931.50684931504;5004.174311238605;5020.899582008413;5121.28302037715;5297.231901374356;5302.594812374724;5310.336207974004;5335.439778823167;5343.385510666323;1622.6430185359202;1623.5454072859618;1625.1955282135418;1630.013841625823;1644.5313085770738;1205.5238180918664;1265.8480982282185;1267.0623738433676;1269.7016201192712;1302.2056545507232;5291.037019269222;5304.7347632618985;5318.867028324245;5359.839204823861;5363.785448582091;5516.806911758069;5522.199281104217;5523.944760552343;5570.164475328733;5583.609147359646;5122.948770512247;5288;5295;5299.8410047698635;5359.866003349947;2884.278930267433;2890.8120972136744;2898.1885072179825;2904.549794781812;2906.462304473679;5527.474889885454;5717.42825717425;5725.742341594555;5766.192733017381;5802.390748971297;5399.217113518596;5547.611667183259;5581.655704604076;5602.607817452821;5628.634138780966;5635.295588051494;5645.633033852787;5657.6039677223025;5728.79949201776;5729.283839520143;5414.5668346532975;5424.802954803311;5452.836414907559;5493.346924295459;5500.22996780459;5046.293518907282;5189.794337406663;5419.539339156216;5449.264349312792;5483.698396588066;5692.3530558290595;5703.486686198262;5716.5426765859465;5735.36910939788;5737.942620573908;4519.254323036794;4568.908621827479;4598.931016034695;4612.86161415158;4616.815327386867;5240.868978275574;5489.258950041693;5555.333359996826;5560.581147200981;5567.805126820542;5406.891862162656;5416;5424.175955950966;5474.589405794661;5493.615446918837;5223;5361.705106219039;5411.431799660979;5444.183372494158;5445.156000819879;5384.892302154013;5414.620976531763;5420.810271640474;5429.67421954684;5431.6740995540395;5440.858388822525;5453.182022696627;5456.645318054314;5464.781408743605;5468.589855760754;5213.895722085461;5245.370555533208;5272.209168624584;5316.680999140064;5348.786048558014 22:08:21 INFO - PROCESS | 30313 | |5;yui.html;853.2193043365321;861.8362511122887;905.8052518708477;913.5438298795917;926.7497775600584;17010;18302.084895755208;18713.251469941202;19321;19579.5105122372;17660;18419.907900460512;19188;19286.32497862575;19352.322668706598;865.1780808232173;870.1646419437332;887.6360692116201;889.1686273334453;891.3047822698305;867.5835598912525;879.4020066354876;880.5993273060774;885.3890815337396;887.5739644970386;919.9310051746112;921.3366376209152;924.1497822003772;924.3437159616681;924.3852837862813;916.2578311567652;922.1654402765508;923.1276443760648;923.1691477670117;923.2982932970923;667.8731041102175;671.0069097735379;672.4250765595394;672.9629870357128;673.1518286958419;18069.909650451795;18157.36449224271;18457.907710461495;18568.071596420126;18838.246470141177;17150.313987440488;17152.82847171525;17537.386191483238;17552.473425797245;18241.908790455964;13853.584392468241;14124.505642302573;14259.572212833527;14285.142891426547;14342.569722908329;3994.4807175067053;4064.593540645941;4082.632563069338;4097.201045796071;4205.053862880858;85922.57038714766;86700.56649716775;87464.56267718684;89205.10794892033;90252.54873725721;13474.278500892058;13571.59285221445;13608.115472494255;13677;13734.175949443066;26870.462590748077;26902.32744181372;26980.460390792075;27346.5898011526;27371.45257094847;9196.08039196075;9258;9446.811063778687;9525.5713492893;9599.47202903833;4556.544345565417;4802.399700037496;4823.614110871122;4843.128236917389;4905.558499735041;3603.1532589841368;3686.3548878946076;3686.576043754949;3719.386301260316;3733.383991641403;631.3749388105742;634.2832599163008;637.4995628431659;639.523554951564;653.0922018394435;803.694596053496;813.2558708781398;822.623132042967;839.7061028639927;863.5164307987548;10328.328658637165;11541.065206570433;11583.942080289713;11675.532978680758;11723.120765942589;853.5433543054436;856.5545916123581;862.0775769926119;877.8595424732013;887.4896934262824;5271.501784752814;5285.762140703678;5340.332458442695;5402.51377376038;5403.648762830403;64926.67536662286;65486;69389;78636;79147.60426197948;72374.27625723781;73106.26893730994;75086.62456687681;75239.24760752323;76987;61897;62289.68855155695;62829.37170628235;63076.36923630705;64756.352436475034;9904.504774761377;10081.01979040759;10132.491041486763;10145.492725363554;10256.12822910061;45528.31707524456;45989.77005114953;46249.537504624524;46604.7669761649;46857.765711171225;51477.48522514727;51707.741461292455;51867.2219916694;52168;52180.47819521756;13500.392482338122;13696.31518424055;13799.655008624864;13889.097208681404;14136;14716.264186790831;14798.038127521677;14825.703485930006;15186.31661575254;15764.684706305581;14377.784333235219;14619.122852628876;14802.62993425173;15441.073535587451;15508.457203997807;13878.167309961435;13892.93053534726;13899.305034748424;14735.26323683833;14892;13710.794338084737;13787.172769633855;13861.930690346484;13889.513867014606;14187.432502699776;9840.311178217456;10031.849522257025;10339.63811266602;10413.53139108757;10464.63373781914;11484.310941343547;11494.540218391505;11636.883631163919;11716.77828342063;11749.530018799152 22:08:21 INFO - PROCESS | 30313 | __end_tp_report 22:08:21 INFO - PROCESS | 30313 | __start_cc_report 22:08:21 INFO - PROCESS | 30313 | _x_x_mozilla_cycle_collect,1498 22:08:21 INFO - PROCESS | 30313 | __end_cc_report 22:08:21 INFO - PROCESS | 30313 | __startTimestamp1492492101342__endTimestamp 22:08:21 INFO - PROCESS | 30313 | 22:08:21 INFO - PROCESS | 30313 | ------- Summary: start ------- 22:08:21 INFO - PROCESS | 30313 | Number of tests: 6 22:08:21 INFO - PROCESS | 30313 | 22:08:21 INFO - PROCESS | 30313 | [#0] dojo.html Cycles:165 Average:5761.40 Median:6034.97 stddev:661.59 (11.0%) stddev-sans-first:635.70 22:08:21 INFO - PROCESS | 30313 | Values: 3337.5 3372.2 3398.4 3421.8 3446.2 5691.0 5766.1 5796.0 5808.3 5819.8 5793.7 5830.2 5846.6 5852.6 5858.7 5252.4 5273.4 5285.6 5285.7 5368.5 5115.6 5115.8 5362.2 5377.5 5378.1 5220.7 5222.6 5317.0 5326.6 5350.9 5342.4 5344.6 5345.8 5354.0 5356.7 5064.5 5205.5 5262.7 5315.9 5324.1 5594.5 5620.7 5627.3 5688.9 5712.7 6150.8 6179.9 6180.5 6187.4 6192.3 6180.6 6214.2 6229.3 6237.8 6249.8 5636.5 5651.3 5740.6 5779.5 5780.2 6348.5 6348.7 6353.8 6353.8 6354.6 6035.9 6118.6 6120.8 6123.3 6136.3 5940.3 5970.3 6125.8 6141.0 6211.1 6188.9 6203.0 6207.2 6208.9 6209.7 5975.2 6016.9 6023.0 6122.9 6209.2 4692.1 4730.6 4744.4 4753.0 4757.1 4088.2 4089.8 4172.7 4242.4 4253.6 5948.1 6019.9 6036.8 6040.8 6047.3 6241.8 6272.9 6275.6 6279.2 6290.1 5658.1 6035.0 6038.7 6050.9 6080.5 5131.2 5199.6 5236.1 5288.0 5297.9 6487.7 6524.6 6526.3 6531.2 6532.1 6178.4 6194.9 6232.9 6243.3 6243.3 6271.0 6300.4 6415.2 6434.0 6536.2 6163.4 6164.1 6164.5 6168.3 6173.4 6274.4 6276.3 6280.4 6280.5 6286.2 5719.7 5888.1 5944.0 6014.4 6117.1 6083.6 6103.7 6108.0 6109.9 6144.7 6057.5 6066.4 6089.6 6091.7 6094.6 5875.4 5895.8 5946.6 6043.1 6073.7 6009.3 6033.6 6037.8 6058.3 6058.8 22:08:21 INFO - PROCESS | 30313 | 22:08:21 INFO - PROCESS | 30313 | [#1] ext.html Cycles:180 Average:46869.01 Median:334080.50 stddev:79595.95 (23.8%) stddev-sans-first:79744.03 22:08:21 INFO - PROCESS | 30313 | Values: 784.0 840.0 859.9 914.5 921.2 30993.2 43402.1 43564.8 43650.6 43689.1 40384.4 40535.8 40632.6 45821.1 45939.3 7631.0 8712.4 8841.9 8842.8 8851.6 7634.3 7709.0 7712.0 7716.8 10453.9 10802.1 10824.1 10825.2 10831.6 10837.5 10714.9 10733.0 10733.3 10733.8 10749.4 10450.3 10513.1 10524.1 10529.3 10536.2 41404.6 41462.0 41540.2 41566.8 41639.6 4200.8 4265.6 4286.6 4362.5 4370.8 29266.4 29624.1 29662.3 30083.7 30796.0 4326.5 4397.8 4406.6 4414.2 4500.0 222214.0 222838.9 223034.0 223040.0 223137.0 53636.5 53727.7 53755.5 53769.2 53847.0 56103.2 56487.4 56591.7 56916.0 56987.4 14938.0 15115.2 15131.1 15134.5 15139.3 12953.0 12976.3 13000.7 13001.6 13004.0 12070.5 12228.1 13313.4 13871.5 13933.4 5517.9 5526.9 5624.6 5634.9 5651.1 962.5 962.7 966.5 967.8 975.6 26572.7 28321.0 28506.9 28608.9 28688.1 1055.0 1066.0 1077.4 1081.1 1133.9 15420.3 16883.9 17250.9 17469.3 17557.0 336111.0 337469.0 337736.0 339009.0 340799.0 60112.4 60277.4 60367.1 60457.0 60582.7 1514.6 1553.2 1576.5 1581.2 1584.5 30229.2 31299.4 31319.0 31756.2 31851.2 42599.4 45911.0 46651.8 52523.5 52724.0 333771.0 334390.0 335015.0 337175.0 337559.0 33333.0 33363.7 33372.5 33530.0 33811.0 34104.8 40406.2 43343.6 43702.6 44029.8 30233.4 30830.8 31505.0 31922.2 31964.2 31782.2 31819.8 31825.0 32124.0 32381.8 36349.3 36384.8 36587.3 36770.0 37227.4 29711.6 30159.4 30921.4 31031.2 31057.8 25985.9 26274.7 26417.2 26481.6 26839.6 22:08:21 INFO - PROCESS | 30313 | 22:08:21 INFO - PROCESS | 30313 | [#2] jquery.html Cycles:180 Average:39185.26 Median:24965.06 stddev:118715.16 (475.5%) stddev-sans-first:119012.48 22:08:21 INFO - PROCESS | 30313 | Values: 409.2 465.7 469.5 484.0 484.2 18978.7 19956.0 20553.7 20658.0 20687.1 21557.9 22032.7 22189.6 22390.8 22587.0 6195.2 6326.7 6520.1 6574.7 6602.1 6355.7 6679.6 6682.2 6685.5 6686.8 6384.7 6598.0 6642.5 6680.0 6691.5 6374.8 6609.0 6662.8 6665.9 6672.7 6432.4 6440.8 6477.5 6484.0 6484.4 24914.8 25015.4 25085.1 25106.1 25278.6 3096.0 3153.4 3154.8 3157.8 3202.1 16318.7 16343.8 16527.8 16597.0 16623.4 2269.7 2318.4 2341.3 2362.8 2382.4 88303.0 88965.0 89445.6 91387.0 91703.5 14729.8 17670.7 18653.7 19511.9 19789.6 27028.6 28147.3 36460.0 36515.3 36548.5 9829.6 9857.0 9900.9 9929.6 10074.7 8310.2 8346.0 8363.7 8526.1 8542.6 9004.4 9175.5 9175.9 9383.9 9420.9 3829.6 3935.3 3949.4 3974.0 4004.1 942.5 944.1 948.2 963.3 964.4 19841.7 20188.2 21218.5 21543.6 21552.6 973.5 1068.9 1114.7 1124.3 1139.0 10861.2 11456.8 11499.5 11527.8 11535.0 682065.0 719451.0 720457.0 740196.0 750416.0 121311.4 125833.4 126141.0 127776.0 130122.0 1335.1 1353.2 1376.5 1395.2 1404.0 14377.7 18429.3 19352.7 19598.7 19760.9 52253.2 52629.7 53096.7 53486.0 54768.0 66350.7 66596.0 66718.3 67514.0 67711.7 12635.3 12711.2 12756.7 12784.0 12874.7 14083.1 14111.2 14208.1 14298.4 14343.5 12314.6 12421.8 12447.4 12464.4 12631.4 11424.4 11432.4 11634.7 11749.2 11816.2 12342.4 12599.8 12850.3 12884.3 13343.2 14784.9 14810.8 14905.7 14939.7 15026.7 13719.2 13873.8 13999.2 14103.3 14181.5 22:08:21 INFO - PROCESS | 30313 | 22:08:21 INFO - PROCESS | 30313 | [#3] mootools.html Cycles:180 Average:6955.79 Median:2410.08 stddev:4392.07 (182.2%) stddev-sans-first:4385.50 22:08:21 INFO - PROCESS | 30313 | Values: 1534.9 1540.9 1558.3 1564.1 1590.9 10766.8 11493.4 11498.9 11499.2 11508.3 10379.9 10597.7 10620.3 10624.6 11241.0 2316.3 2330.1 2355.1 2360.9 2361.0 2334.5 2369.1 2481.6 2481.9 2486.9 2385.0 2407.0 2411.7 2473.5 2481.6 2301.3 2312.1 2404.9 2411.2 2418.5 2378.9 2387.2 2401.8 2409.1 2411.1 11285.8 11430.8 11461.4 11467.3 11483.9 5731.1 5840.9 5867.3 5880.9 5882.8 3491.9 3573.6 3574.0 3631.7 3635.6 1330.7 1385.8 1398.1 1409.3 1477.6 16287.0 16579.0 16622.3 16662.3 16730.6 4670.2 4751.8 4858.9 4859.7 4885.9 13000.2 13010.3 13015.9 13020.1 13028.1 5965.3 5974.4 5975.0 5977.6 5983.5 5214.8 5470.2 5513.0 5513.1 5546.6 3933.3 4041.7 4081.3 4115.3 4152.2 1091.4 1093.7 1095.1 1104.9 1108.5 1021.6 1025.4 1035.9 1042.4 1046.1 6693.0 6821.4 6848.5 6908.5 6940.5 1030.9 1048.6 1056.7 1082.5 1101.2 4493.7 4584.6 4609.5 4671.6 4697.0 14031.3 14687.5 14706.0 14729.9 14761.9 12052.9 14603.8 14622.5 14653.9 14658.6 8575.9 9392.2 9522.0 9538.0 9595.6 7092.3 7127.9 7257.7 7305.3 7321.4 12165.1 12274.4 12285.8 12348.5 12450.9 12609.4 12633.7 12655.9 12711.1 12871.3 8802.5 8941.4 8976.3 8989.0 8995.2 10352.0 10360.2 10384.9 10415.6 10485.2 8947.9 9011.4 9025.5 9063.2 9241.2 8916.5 8978.0 9011.7 9023.9 9131.7 8013.3 8122.5 8181.3 8184.5 8193.3 6103.4 6192.0 6193.5 6238.7 6341.7 5895.7 5964.9 6025.3 6099.4 6173.4 22:08:21 INFO - PROCESS | 30313 | 22:08:21 INFO - PROCESS | 30313 | [#4] prototype.html Cycles:180 Average:4721.44 Median:5218.32 stddev:1240.88 (23.8%) stddev-sans-first:1201.71 22:08:21 INFO - PROCESS | 30313 | Values: 424.2 433.9 436.4 440.0 442.0 5157.6 5217.0 5219.7 5263.9 5286.3 5061.7 5071.1 5095.8 5121.3 5127.2 4334.3 4370.5 4402.0 4407.0 4413.0 4349.5 4363.1 4377.6 4389.5 4397.7 4336.7 4346.8 4356.4 4365.3 4390.3 4149.2 4284.6 4353.6 4360.6 4459.3 4088.5 4095.5 4101.3 4110.6 4129.8 5023.6 5023.7 5030.6 5054.9 5075.5 4887.9 4981.5 4998.5 5067.9 5072.3 5363.1 5369.7 5371.5 5381.9 5394.7 4522.8 4536.7 4545.3 4560.7 4580.0 5350.0 5581.7 5609.9 5619.1 5623.0 4653.5 4654.0 4657.2 4663.8 4665.9 4750.9 4792.3 4793.4 4797.7 4800.5 4794.5 4931.5 5004.2 5020.9 5121.3 5297.2 5302.6 5310.3 5335.4 5343.4 1622.6 1623.5 1625.2 1630.0 1644.5 1205.5 1265.8 1267.1 1269.7 1302.2 5291.0 5304.7 5318.9 5359.8 5363.8 5516.8 5522.2 5523.9 5570.2 5583.6 5122.9 5288.0 5295.0 5299.8 5359.9 2884.3 2890.8 2898.2 2904.5 2906.5 5527.5 5717.4 5725.7 5766.2 5802.4 5399.2 5547.6 5581.7 5602.6 5628.6 5635.3 5645.6 5657.6 5728.8 5729.3 5414.6 5424.8 5452.8 5493.3 5500.2 5046.3 5189.8 5419.5 5449.3 5483.7 5692.4 5703.5 5716.5 5735.4 5737.9 4519.3 4568.9 4598.9 4612.9 4616.8 5240.9 5489.3 5555.3 5560.6 5567.8 5406.9 5416.0 5424.2 5474.6 5493.6 5223.0 5361.7 5411.4 5444.2 5445.2 5384.9 5414.6 5420.8 5429.7 5431.7 5440.9 5453.2 5456.6 5464.8 5468.6 5213.9 5245.4 5272.2 5316.7 5348.8 22:08:21 INFO - PROCESS | 30313 | 22:08:21 INFO - PROCESS | 30313 | [#5] yui.html Cycles:180 Average:18704.22 Median:46119.65 stddev:22915.63 (49.7%) stddev-sans-first:22940.71 22:08:21 INFO - PROCESS | 30313 | Values: 853.2 861.8 905.8 913.5 926.7 17010.0 18302.1 18713.3 19321.0 19579.5 17660.0 18419.9 19188.0 19286.3 19352.3 865.2 870.2 887.6 889.2 891.3 867.6 879.4 880.6 885.4 887.6 919.9 921.3 924.1 924.3 924.4 916.3 922.2 923.1 923.2 923.3 667.9 671.0 672.4 673.0 673.2 18069.9 18157.4 18457.9 18568.1 18838.2 17150.3 17152.8 17537.4 17552.5 18241.9 13853.6 14124.5 14259.6 14285.1 14342.6 3994.5 4064.6 4082.6 4097.2 4205.1 85922.6 86700.6 87464.6 89205.1 90252.5 13474.3 13571.6 13608.1 13677.0 13734.2 26870.5 26902.3 26980.5 27346.6 27371.5 9196.1 9258.0 9446.8 9525.6 9599.5 4556.5 4802.4 4823.6 4843.1 4905.6 3603.2 3686.4 3686.6 3719.4 3733.4 631.4 634.3 637.5 639.5 653.1 803.7 813.3 822.6 839.7 863.5 10328.3 11541.1 11583.9 11675.5 11723.1 853.5 856.6 862.1 877.9 887.5 5271.5 5285.8 5340.3 5402.5 5403.6 64926.7 65486.0 69389.0 78636.0 79147.6 72374.3 73106.3 75086.6 75239.2 76987.0 61897.0 62289.7 62829.4 63076.4 64756.4 9904.5 10081.0 10132.5 10145.5 10256.1 45528.3 45989.8 46249.5 46604.8 46857.8 51477.5 51707.7 51867.2 52168.0 52180.5 13500.4 13696.3 13799.7 13889.1 14136.0 14716.3 14798.0 14825.7 15186.3 15764.7 14377.8 14619.1 14802.6 15441.1 15508.5 13878.2 13892.9 13899.3 14735.3 14892.0 13710.8 13787.2 13861.9 13889.5 14187.4 9840.3 10031.8 10339.6 10413.5 10464.6 11484.3 11494.5 11636.9 11716.8 11749.5 22:08:21 INFO - PROCESS | 30313 | -------- Summary: end -------- 22:08:21 INFO - PROCESS | 30313 | 22:08:22 INFO - TEST-INFO | 30313: exit 0 22:08:22 INFO - TEST-OK | dromaeo_css | took 1116197ms 22:08:22 INFO - TEST-START | kraken 22:08:22 INFO - operating with platform_type : linux_ 22:08:22 INFO - Initialising browser for kraken test... 22:08:22 INFO - TEST-INFO | started process 30634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkxUt3_/profile http://localhost:55520/getInfo.html) 22:08:26 INFO - PROCESS | 30634 | __metrics Screen width/height:1600/1200 22:08:26 INFO - PROCESS | 30634 | colorDepth:24 22:08:26 INFO - PROCESS | 30634 | Browser inner width/height: 1024/697 22:08:26 INFO - PROCESS | 30634 | __metrics 22:08:27 INFO - PROCESS | 30634 | 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" 22:08:27 INFO - PROCESS | 30634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:08:28 INFO - TEST-INFO | 30634: exit 0 22:08:28 INFO - Browser initialized. 22:08:28 INFO - Running cycle 1/1 for kraken test... 22:08:28 INFO - TEST-INFO | started process 30731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkxUt3_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:40 INFO - PROCESS | 30731 | RSS: Main: 139952128 22:08:40 INFO - PROCESS | 30731 | 22:08:42 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55520/tests/kraken/driver.html?testName=audio-beat-detection) 22:08:43 INFO - PROCESS | 30731 | RSS: Main: 183128064 22:08:43 INFO - PROCESS | 30731 | 22:08:45 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55520/tests/kraken/driver.html?testName=audio-dft) 22:08:46 INFO - PROCESS | 30731 | RSS: Main: 173809664 22:08:46 INFO - PROCESS | 30731 | 22:08:49 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55520/tests/kraken/driver.html?testName=audio-fft) 22:08:49 INFO - PROCESS | 30731 | RSS: Main: 266063872 22:08:49 INFO - PROCESS | 30731 | 22:08:51 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55520/tests/kraken/driver.html?testName=audio-oscillator) 22:08:52 INFO - PROCESS | 30731 | RSS: Main: 172482560 22:08:52 INFO - PROCESS | 30731 | 22:08:54 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55520/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:08:55 INFO - PROCESS | 30731 | RSS: Main: 174698496 22:08:55 INFO - PROCESS | 30731 | 22:08:58 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55520/tests/kraken/driver.html?testName=imaging-darkroom) 22:08:58 INFO - PROCESS | 30731 | RSS: Main: 213356544 22:08:58 INFO - PROCESS | 30731 | 22:09:02 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55520/tests/kraken/driver.html?testName=imaging-desaturate) 22:09:02 INFO - PROCESS | 30731 | RSS: Main: 211931136 22:09:02 INFO - PROCESS | 30731 | 22:09:05 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55520/tests/kraken/driver.html?testName=json-parse-financial) 22:09:06 INFO - PROCESS | 30731 | RSS: Main: 210022400 22:09:06 INFO - PROCESS | 30731 | 22:09:07 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55520/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:09:08 INFO - PROCESS | 30731 | RSS: Main: 172912640 22:09:08 INFO - PROCESS | 30731 | 22:09:09 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55520/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:09:10 INFO - PROCESS | 30731 | RSS: Main: 179077120 22:09:10 INFO - PROCESS | 30731 | 22:09:12 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55520/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:09:13 INFO - PROCESS | 30731 | RSS: Main: 189935616 22:09:13 INFO - PROCESS | 30731 | 22:09:15 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55520/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:09:16 INFO - PROCESS | 30731 | RSS: Main: 197746688 22:09:16 INFO - PROCESS | 30731 | 22:09:19 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55520/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:09:19 INFO - PROCESS | 30731 | RSS: Main: 194932736 22:09:19 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | Cycle 1(1): loaded http://localhost:55520/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55520/tests/kraken/driver.html?testName=ai-astar) 22:09:21 INFO - PROCESS | 30731 | RSS: Main: 245178368 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | __start_tp_report 22:09:21 INFO - PROCESS | 30731 | _x_x_mozilla_page_load 22:09:21 INFO - PROCESS | 30731 | _x_x_mozilla_page_load_details 22:09:21 INFO - PROCESS | 30731 | |i|pagename|runs| 22:09:21 INFO - PROCESS | 30731 | |0;ai-astar;103;111;112;112;114;112;115;112;111;114 22:09:21 INFO - PROCESS | 30731 | |1;audio-beat-detection;142;114;116;156;122;115;114;121;139;115 22:09:21 INFO - PROCESS | 30731 | |2;audio-dft;161;162;165;165;161;162;160;160;161;161 22:09:21 INFO - PROCESS | 30731 | |3;audio-fft;74;75;74;123;75;77;75;75;97;75 22:09:21 INFO - PROCESS | 30731 | |4;audio-oscillator;82;81;111;82;84;82;102;83;82;99 22:09:21 INFO - PROCESS | 30731 | |5;imaging-gaussian-blur;113;112;113;113;112;112;113;113;113;113 22:09:21 INFO - PROCESS | 30731 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;146;146 22:09:21 INFO - PROCESS | 30731 | |7;imaging-desaturate;94;95;94;94;94;94;94;94;94;93 22:09:21 INFO - PROCESS | 30731 | |8;json-parse-financial;54;55;55;53;54;54;54;54;53;54 22:09:21 INFO - PROCESS | 30731 | |9;json-stringify-tinderbox;54;53;53;53;53;53;54;54;54;53 22:09:21 INFO - PROCESS | 30731 | |10;stanford-crypto-aes;79;75;80;75;81;86;79;76;79;79 22:09:21 INFO - PROCESS | 30731 | |11;stanford-crypto-ccm;130;139;129;132;131;121;120;118;163;138 22:09:21 INFO - PROCESS | 30731 | |12;stanford-crypto-pbkdf2;158;160;158;159;158;160;157;156;156;162 22:09:21 INFO - PROCESS | 30731 | |13;stanford-crypto-sha256-iterative;59;60;60;59;60;64;58;59;59;62 22:09:21 INFO - PROCESS | 30731 | __end_tp_report 22:09:21 INFO - PROCESS | 30731 | __start_cc_report 22:09:21 INFO - PROCESS | 30731 | _x_x_mozilla_cycle_collect,1688 22:09:21 INFO - PROCESS | 30731 | __end_cc_report 22:09:21 INFO - PROCESS | 30731 | __startTimestamp1492492161553__endTimestamp 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | ------- Summary: start ------- 22:09:21 INFO - PROCESS | 30731 | Number of tests: 14 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:3.31 (3.0%) stddev-sans-first:1.42 22:09:21 INFO - PROCESS | 30731 | Values: 103.0 111.0 112.0 112.0 114.0 112.0 115.0 112.0 111.0 114.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:121.50 stddev:14.88 (12.2%) stddev-sans-first:14.52 22:09:21 INFO - PROCESS | 30731 | Values: 142.0 114.0 116.0 156.0 122.0 115.0 114.0 121.0 139.0 115.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.81 (1.1%) stddev-sans-first:1.90 22:09:21 INFO - PROCESS | 30731 | Values: 161.0 162.0 165.0 165.0 161.0 162.0 160.0 160.0 161.0 161.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:16.00 (21.3%) stddev-sans-first:16.71 22:09:21 INFO - PROCESS | 30731 | Values: 74.0 75.0 74.0 123.0 75.0 77.0 75.0 75.0 97.0 75.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:10.92 (13.3%) stddev-sans-first:11.30 22:09:21 INFO - PROCESS | 30731 | Values: 82.0 81.0 111.0 82.0 84.0 82.0 102.0 83.0 82.0 99.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:09:21 INFO - PROCESS | 30731 | Values: 113.0 112.0 113.0 113.0 112.0 112.0 113.0 113.0 113.0 113.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 22:09:21 INFO - PROCESS | 30731 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 22:09:21 INFO - PROCESS | 30731 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 22:09:21 INFO - PROCESS | 30731 | Values: 54.0 55.0 55.0 53.0 54.0 54.0 54.0 54.0 53.0 54.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.50 22:09:21 INFO - PROCESS | 30731 | Values: 54.0 53.0 53.0 53.0 53.0 53.0 54.0 54.0 54.0 53.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:3.25 (4.1%) stddev-sans-first:3.44 22:09:21 INFO - PROCESS | 30731 | Values: 79.0 75.0 80.0 75.0 81.0 86.0 79.0 76.0 79.0 79.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:131.50 stddev:13.00 (9.9%) stddev-sans-first:13.77 22:09:21 INFO - PROCESS | 30731 | Values: 130.0 139.0 129.0 132.0 131.0 121.0 120.0 118.0 163.0 138.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.50 stddev:1.90 (1.2%) stddev-sans-first:2.01 22:09:21 INFO - PROCESS | 30731 | Values: 158.0 160.0 158.0 159.0 158.0 160.0 157.0 156.0 156.0 162.0 22:09:21 INFO - PROCESS | 30731 | 22:09:21 INFO - PROCESS | 30731 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.00 Median:60.00 stddev:1.76 (2.9%) stddev-sans-first:1.83 22:09:21 INFO - PROCESS | 30731 | Values: 59.0 60.0 60.0 59.0 60.0 64.0 58.0 59.0 59.0 62.0 22:09:21 INFO - PROCESS | 30731 | -------- Summary: end -------- 22:09:21 INFO - PROCESS | 30731 | 22:09:22 INFO - TEST-INFO | 30731: exit 0 22:09:22 INFO - TEST-OK | kraken | took 60419ms 22:09:22 INFO - SUITE-END | took 1176s 22:09:22 INFO - Completed test suite (00:19:36) 22:09:22 INFO - javascript benchmark 22:09:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7826.903035136424, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.5327454156413, 3372.2412457197133, 3398.371301309257, 3421.760476766627, 3446.2245994651207, 5690.9715451422735, 5766.077427611583, 5796.0, 5808.273965754281, 5819.825405237839, 5793.7103144842695, 5830.242068531085, 5846.590738648296, 5852.648841069539, 5858.677772722499, 5252.395974462938, 5273.393559740641, 5285.6300058995885, 5285.735713214343, 5368.516833484986, 5115.565176959963, 5115.795368185268, 5362.249285100089, 5377.516023557879, 5378.085725426687, 5220.738963051832, 5222.63441559091, 5316.9734151329185, 5326.573874090063, 5350.892982140354, 5342.412334643186, 5344.599155063347, 5345.7594408251525, 5353.973230133864, 5356.651817631841, 5064.468230835783, 5205.479452054764, 5262.736863156827, 5315.946840531584, 5324.1215199492035, 5594.468525490072, 5620.690862002588, 5627.324721033461, 5688.914666279968, 5712.714364281769, 6150.84622884427, 6179.938200617981, 6180.536459765535, 6187.412195841388, 6192.287886892975, 6180.598261113013, 6214.161088253073, 6229.345918678564, 6237.812865614039, 6249.843753906143, 5636.464535869127, 5651.32184137902, 5740.626859254176, 5779.508741756914, 5780.21967034445, 6348.460380867678, 6348.650824204621, 6353.777617783356, 6353.809385718436, 6354.555181137276, 6035.8792824143275, 6118.6022908511695, 6120.785772497941, 6123.326434092335, 6136.325004249529, 5940.34656187819, 5970.31341395745, 6125.845966769368, 6140.969295153495, 6211.130441738161, 6188.938110618927, 6202.968985155046, 6207.193064901534, 6208.937910620836, 6209.6895155242055, 5975.163477113208, 6016.879662406727, 6022.969885150546, 6122.908156377658, 6209.223847019122, 4692.085043416501, 4730.62155027597, 4744.383230180055, 4753.0, 4757.14371413142, 4088.2232375848494, 4089.754614723126, 4172.666186705056, 4242.4272723181975, 4253.553376895444, 5948.10778383246, 6019.939800601938, 6036.849078773066, 6040.7583696651645, 6047.2743270806905, 6241.812745617639, 6272.937270627326, 6275.592086514362, 6279.152314437584, 6290.056491526308, 5658.122990936411, 6034.969825150846, 6038.698065096728, 6050.909236361458, 6080.513558915276, 5131.204663277198, 5199.584033277329, 5236.083685355047, 5287.973560132252, 5297.894042119136, 6487.708053137526, 6524.64114473699, 6526.347365263436, 6531.183602049839, 6532.08550802888, 6178.351273116438, 6194.907076393948, 6232.906506402317, 6243.250809902841, 6243.344448832807, 6270.996640537492, 6300.432961033345, 6415.1981002374705, 6433.967830160819, 6536.248331441945, 6163.414475624809, 6164.075388691732, 6164.47601953839, 6168.25980882297, 6173.382661733791, 6274.435300822948, 6276.340984196776, 6280.403361680633, 6280.5289603279025, 6286.18279623646, 5719.685417302088, 5888.087346461305, 5943.970280148572, 6014.428629280212, 6117.1130186123655, 6083.574149809471, 6103.69481525913, 6107.969460152671, 6109.877802444015, 6144.6620435874665, 6057.454829065406, 6066.393360664075, 6089.634621922699, 6091.7258723358445, 6094.573379863367, 5875.412458754261, 5895.823125306248, 5946.643201407756, 6043.12374705674, 6073.726682299395, 6009.278886533644, 6033.577649564664, 6037.758489660365, 6058.303295121117, 6058.848528786815], "value": 5716.633893288071, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.9608019599019, 839.9790005249868, 859.9183077607627, 914.5472990869521, 921.1847514949276, 30993.225169370777, 43402.131957360834, 43564.78217608915, 43650.563494365044, 43689.126217475634, 40384.39423408651, 40535.79732101343, 40632.593674063326, 45821.08357832841, 45939.31091033629, 7630.961845190766, 8712.390132690714, 8841.911580884173, 8842.778930526756, 8851.601677924476, 7634.312911837934, 7709.0, 7712.0, 7716.7684969451, 10453.947730261376, 10802.081823045051, 10824.079953203987, 10825.24223304369, 10831.566737330537, 10837.512311945942, 10714.892851071467, 10733.0, 10733.302335348217, 10733.838992415082, 10749.408782516959, 10450.320729152656, 10513.053825155695, 10524.052835244787, 10529.262951593391, 10536.157107431387, 41404.585954140675, 41462.0, 41540.1691966162, 41566.79216603928, 41639.583604164174, 4200.831966721327, 4265.573442655741, 4286.57134286572, 4362.47650281965, 4370.8033138508845, 29266.414671706658, 29624.111276661733, 29662.258443538867, 30083.69916300853, 30796.0, 4326.480822301344, 4397.824087036547, 4406.625436837872, 4414.183376075404, 4500.0, 222214.0, 222838.88580557157, 223034.0, 223040.0, 223137.0, 53636.46363536393, 53727.73136134294, 53755.46244537583, 53769.1934620981, 53847.0, 56103.15845262324, 56487.43512564904, 56591.71704141453, 56916.0, 56987.430125699044, 14938.0, 15115.168665723491, 15131.092134471966, 15134.545963621109, 15139.318730657147, 12953.0, 12976.286304253168, 13000.739985200244, 13001.609951701465, 13004.024698147678, 12070.517179312905, 12228.082893783001, 13313.40089695966, 13871.514496992557, 13933.442662293597, 5517.862053448615, 5526.917096243559, 5624.606277560531, 5634.915476267859, 5651.095824668116, 962.4562122400821, 962.6582563190107, 966.5167416291854, 967.8499832525829, 975.6487664440796, 26572.734272657413, 28321.0, 28506.85746571254, 28608.856955715088, 28688.13935581936, 1055.0188324857802, 1066.0405634928472, 1077.3643550305358, 1081.124289325633, 1133.8752737198902, 15420.306086226146, 16883.91558042202, 17250.913745431193, 17469.30122795074, 17557.034363110153, 336111.0, 337469.0, 337736.0, 339009.0, 340799.0, 60112.39887601155, 60277.39722602806, 60367.094493582634, 60457.0, 60582.69708651429, 1514.6289159155856, 1553.1672626300847, 1576.4955214331533, 1581.1777875504672, 1584.5088022712996, 30229.244268892573, 31299.37401252008, 31319.0, 31756.206094847814, 31851.20371990719, 42599.361009585504, 45911.0, 46651.76674116608, 52523.474765251856, 52724.0, 333771.0, 334390.0, 335015.0, 337175.0, 337559.0, 33333.0, 33363.66636333606, 33372.49941250835, 33530.0, 33811.0, 34104.829475852464, 40406.1918761629, 43343.56656433395, 43702.56297436985, 44029.77985110182, 30233.395332093674, 30830.84584577063, 31505.0, 31922.20194495156, 31964.200894976882, 31782.205444864063, 31819.84090079535, 31825.04524864258, 32124.0, 32381.838090809397, 36349.27301454009, 36384.818075909454, 36587.26825463529, 36770.0, 37227.441588376736, 29711.55432668555, 30159.396812064075, 30921.381572367976, 31031.224219393793, 31057.844710776302, 25985.870070649526, 26274.737252627994, 26417.207483775517, 26481.602775957992, 26839.597406039316], "value": 18947.307090953607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.1816367265469, 465.71824046451906, 469.47653366496365, 484.0464285357845, 484.215570775344, 18978.71531927022, 19956.0, 20553.69169462459, 20658.0, 20687.069081891314, 21557.892210538965, 22032.669509957363, 22189.556208875812, 22390.776092239113, 22587.0, 6195.2255968004, 6326.715297811586, 6520.0871877937125, 6574.737010519573, 6602.075709400664, 6355.68221588921, 6679.599224046548, 6682.231543372526, 6685.4985876059245, 6686.799396018103, 6384.680765961683, 6597.967010164966, 6642.5350225484235, 6679.966600166992, 6691.498137639672, 6374.776882809079, 6609.0, 6662.833429164285, 6665.866682666368, 6672.666366681695, 6432.421082102634, 6440.806775796734, 6477.481801455872, 6484.0, 6484.383983521605, 24914.750852491423, 25015.374615634573, 25085.122020729188, 25106.12128575491, 25278.620820687705, 3095.9535606965915, 3153.353562519678, 3154.8422578870964, 3157.8263195524237, 3202.071399294202, 16318.673626527521, 16343.83656163435, 16527.752083718755, 16597.0, 16623.41818036375, 2269.693591365161, 2318.385627808632, 2341.30931375243, 2362.8464149830206, 2382.4401265702545, 88303.0, 88965.0, 89445.55277223638, 91387.0, 91703.54148229283, 14729.779053314209, 17670.674699397598, 18653.720194197096, 19511.902440487705, 19789.60420791576, 27028.59457108145, 28147.296317592223, 36460.0, 36515.26969460596, 36548.45177322342, 9829.55766990487, 9857.0, 9900.851487227554, 9929.602815887429, 10074.69775906724, 8310.168983101763, 8346.0, 8363.665453381796, 8526.104759000216, 8542.615582298811, 9004.41471304363, 9175.54122293896, 9175.862362064574, 9383.906160938439, 9420.905790942003, 3829.5787463379006, 3935.2916475034194, 3949.3878448840474, 3974.025974025974, 4004.0570180917002, 942.4533770413144, 944.1125342178331, 948.170350942925, 963.3352986439335, 964.4068897627908, 19841.702374464105, 20188.192472300943, 21218.514703970573, 21543.56912861734, 21552.56894862094, 973.4694591447678, 1068.893110688925, 1114.6878873915316, 1124.2748427264369, 1138.9772204555863, 10861.239713219999, 11456.828147577793, 11499.482523286471, 11527.827082593767, 11535.0, 682065.0, 719451.0, 720457.0, 740196.0, 750416.0, 121311.39344303223, 125833.37083314525, 126141.0, 127776.0, 130122.0, 1335.125492802216, 1353.2489468344966, 1376.4769387632837, 1395.1907893421792, 1403.9929800350933, 14377.712445750818, 18429.26282948667, 19352.70970935465, 19598.706019409434, 19760.90119549393, 52253.216201757765, 52629.7368513155, 53096.73451632872, 53486.0, 54768.0, 66350.66824665846, 66596.0, 66718.33281667315, 67514.0, 67711.66144169247, 12635.305058221886, 12711.237325760483, 12756.744865102832, 12783.977281817246, 12874.67813304675, 14083.084599501, 14111.153330800185, 14208.07647502909, 14298.428062877785, 14343.497977570734, 12314.568990085305, 12421.75156496883, 12447.439865205906, 12464.376781160725, 12631.431585578855, 11424.428778560872, 11432.428378581204, 11634.6509604712, 11749.177557570887, 11816.172867899508, 12342.382880856101, 12599.811002834782, 12850.293233872228, 12884.291363975071, 13343.199408035549, 14784.852151478777, 14810.777838332218, 14905.701885962437, 14939.701205976036, 15026.699466010838, 13719.176849389069, 13873.791893121814, 13999.230042347768, 14103.2948352584, 14181.503647372705], "value": 11538.057248173985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.9232538373078, 1540.8767298616112, 1558.2831897327235, 1564.1162743050177, 1590.8568228859401, 10766.838497422545, 11493.425328733561, 11498.942505287483, 11499.19505634606, 11508.30950142992, 10379.896201037987, 10597.682069537907, 10620.309679870803, 10624.57501699933, 11241.0, 2316.281952594697, 2330.149495434163, 2355.0697474497565, 2360.8701521416315, 2360.988195059031, 2334.48641298914, 2369.099742098, 2481.6029435290357, 2481.8759062046915, 2486.9005239790386, 2385.0340612052146, 2406.9638955415685, 2411.6623672685837, 2473.480569080495, 2481.5781317176034, 2301.344116926685, 2312.1329501436962, 2404.8677322747244, 2411.2163546847255, 2418.4558474343307, 2378.8691621960784, 2387.164492427654, 2401.8078553715836, 2409.084547871815, 2411.071737381121, 11285.830712539318, 11430.771384572345, 11461.36962467064, 11467.279908013781, 11483.885161148366, 5731.083026715747, 5840.912386314209, 5867.266591676041, 5880.882382352372, 5882.764689412418, 3491.91270218244, 3573.5890372606964, 3573.982130089359, 3631.7276204284785, 3635.63643635637, 1330.7072444062292, 1385.757492438819, 1398.1191849135082, 1409.2953523238382, 1477.5862758427656, 16287.0, 16579.0, 16622.25199865997, 16662.333506659717, 16730.581735456588, 4670.15528866096, 4751.786169622375, 4858.878528036827, 4859.684120532154, 4885.853424397274, 13000.219986800823, 13010.284434356012, 13015.869841301655, 13020.088593798344, 13028.08803383773, 5965.343812180657, 5974.4324289192455, 5974.970125149346, 5977.641341519523, 5983.521318294613, 5214.765335559909, 5470.179473078991, 5512.972435137799, 5513.062779327524, 5546.584006199551, 3933.3116704576582, 4041.6766658667234, 4081.3265811140827, 4115.259253334429, 4152.190322887069, 1091.3615534912165, 1093.7211011192255, 1095.134843473647, 1104.9447527623747, 1108.4734750993375, 1021.5760459409262, 1025.3898930136556, 1035.8705161854768, 1042.3537406807827, 1046.1264843855313, 6692.96653516739, 6821.3519715626935, 6848.486363522756, 6908.516403851782, 6940.514164008572, 1030.907218350352, 1048.5910494906993, 1056.709404913655, 1082.4533610526635, 1101.1906248907046, 4493.6854420190275, 4584.610308123847, 4609.516000819933, 4671.579557839811, 4697.0, 14031.298435078204, 14687.485937992118, 14706.0, 14729.852701472848, 14761.852381476263, 12052.879471205175, 14603.78094328586, 14622.488212912496, 14653.853461465249, 14658.560243192722, 8575.914240857637, 9392.154706076486, 9522.047795220422, 9538.0, 9595.616175352907, 7092.326229008236, 7127.928720712934, 7257.673404696696, 7305.305995930378, 7321.377682897013, 12165.148439609142, 12274.386280686109, 12285.754284914074, 12348.506059757508, 12450.941669958154, 12609.369531523571, 12633.747325053631, 12655.87344126547, 12711.110222284722, 12871.292078935749, 8802.471851688919, 8941.37410381267, 8976.28189744832, 8988.955055224682, 8995.23540499065, 10352.0, 10360.222983276435, 10384.896151038392, 10415.635452759117, 10485.161187105166, 8947.910520894708, 9011.369204155646, 9025.458472491671, 9063.184313411824, 9241.168294853496, 8916.509591972504, 8977.955110224408, 9011.729648110306, 9023.90976090257, 9131.680391186543, 8013.318867896294, 8122.472039317426, 8181.263686268265, 8184.508929464251, 8193.262606365217, 6103.42017508336, 6192.040233763774, 6193.473554747897, 6238.6880655967925, 6341.682915854097, 5895.7052147391605, 5964.9105263420215, 6025.307089684742, 6099.359567245376, 6173.38266173397], "value": 5314.991413263156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.1897974868003, 433.8871893307739, 436.4304582519812, 439.9846005389812, 441.96022357987795, 5157.638965272433, 5216.973915130419, 5219.660722053064, 5263.868403289915, 5286.281958363537, 5061.6709913855575, 5071.087204303224, 5095.847124586259, 5121.308623335848, 5127.179651255799, 4334.3498475228735, 4370.519242883281, 4402.0, 4407.047278323515, 4413.0, 4349.478062632488, 4363.149185908749, 4377.562243775629, 4389.4513185851765, 4397.6587140922, 4336.7181133226395, 4346.804393802271, 4356.368326592642, 4365.3233748768835, 4390.297552391618, 4149.211649786531, 4284.5715428457215, 4353.62994145498, 4360.607545320936, 4459.331100334944, 4088.509378874554, 4095.464200924653, 4101.26177288088, 4110.568390319033, 4129.752214867118, 5023.623228257895, 5023.748812559357, 5030.597552195853, 5054.873628159288, 5075.543201111881, 4887.902241955141, 4981.526754958273, 4998.450170481244, 5067.949320506785, 5072.340595722532, 5363.115086010804, 5369.691032855871, 5371.489708477728, 5381.865453363658, 5394.703291318976, 4522.819087236507, 4536.684361535151, 4545.2954792007295, 4560.703554268962, 4579.992401671627, 5350.0, 5581.6836013054935, 5609.9145469991345, 5619.145681924996, 5622.971885140548, 4653.464851542049, 4653.976730116327, 4657.231556793159, 4663.813447462064, 4665.930011049837, 4750.881227969259, 4792.257200133985, 4793.352897358882, 4797.736124513185, 4800.5199480051715, 4794.50349754794, 4931.50684931504, 5004.174311238605, 5020.899582008413, 5121.28302037715, 5297.231901374356, 5302.594812374724, 5310.336207974004, 5335.439778823167, 5343.385510666323, 1622.6430185359202, 1623.5454072859618, 1625.1955282135418, 1630.013841625823, 1644.5313085770738, 1205.5238180918664, 1265.8480982282185, 1267.0623738433676, 1269.7016201192712, 1302.2056545507232, 5291.037019269222, 5304.7347632618985, 5318.867028324245, 5359.839204823861, 5363.785448582091, 5516.806911758069, 5522.199281104217, 5523.944760552343, 5570.164475328733, 5583.609147359646, 5122.948770512247, 5288.0, 5295.0, 5299.8410047698635, 5359.866003349947, 2884.278930267433, 2890.8120972136744, 2898.1885072179825, 2904.549794781812, 2906.462304473679, 5527.474889885454, 5717.42825717425, 5725.742341594555, 5766.192733017381, 5802.390748971297, 5399.217113518596, 5547.611667183259, 5581.655704604076, 5602.607817452821, 5628.634138780966, 5635.295588051494, 5645.633033852787, 5657.6039677223025, 5728.79949201776, 5729.283839520143, 5414.5668346532975, 5424.802954803311, 5452.836414907559, 5493.346924295459, 5500.22996780459, 5046.293518907282, 5189.794337406663, 5419.539339156216, 5449.264349312792, 5483.698396588066, 5692.3530558290595, 5703.486686198262, 5716.5426765859465, 5735.36910939788, 5737.942620573908, 4519.254323036794, 4568.908621827479, 4598.931016034695, 4612.86161415158, 4616.815327386867, 5240.868978275574, 5489.258950041693, 5555.333359996826, 5560.581147200981, 5567.805126820542, 5406.891862162656, 5416.0, 5424.175955950966, 5474.589405794661, 5493.615446918837, 5223.0, 5361.705106219039, 5411.431799660979, 5444.183372494158, 5445.156000819879, 5384.892302154013, 5414.620976531763, 5420.810271640474, 5429.67421954684, 5431.6740995540395, 5440.858388822525, 5453.182022696627, 5456.645318054314, 5464.781408743605, 5468.589855760754, 5213.895722085461, 5245.370555533208, 5272.209168624584, 5316.680999140064, 5348.786048558014], "value": 4366.453382539404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.2193043365321, 861.8362511122887, 905.8052518708477, 913.5438298795917, 926.7497775600584, 17010.0, 18302.084895755208, 18713.251469941202, 19321.0, 19579.5105122372, 17660.0, 18419.907900460512, 19188.0, 19286.32497862575, 19352.322668706598, 865.1780808232173, 870.1646419437332, 887.6360692116201, 889.1686273334453, 891.3047822698305, 867.5835598912525, 879.4020066354876, 880.5993273060774, 885.3890815337396, 887.5739644970386, 919.9310051746112, 921.3366376209152, 924.1497822003772, 924.3437159616681, 924.3852837862813, 916.2578311567652, 922.1654402765508, 923.1276443760648, 923.1691477670117, 923.2982932970923, 667.8731041102175, 671.0069097735379, 672.4250765595394, 672.9629870357128, 673.1518286958419, 18069.909650451795, 18157.36449224271, 18457.907710461495, 18568.071596420126, 18838.246470141177, 17150.313987440488, 17152.82847171525, 17537.386191483238, 17552.473425797245, 18241.908790455964, 13853.584392468241, 14124.505642302573, 14259.572212833527, 14285.142891426547, 14342.569722908329, 3994.4807175067053, 4064.593540645941, 4082.632563069338, 4097.201045796071, 4205.053862880858, 85922.57038714766, 86700.56649716775, 87464.56267718684, 89205.10794892033, 90252.54873725721, 13474.278500892058, 13571.59285221445, 13608.115472494255, 13677.0, 13734.175949443066, 26870.462590748077, 26902.32744181372, 26980.460390792075, 27346.5898011526, 27371.45257094847, 9196.08039196075, 9258.0, 9446.811063778687, 9525.5713492893, 9599.47202903833, 4556.544345565417, 4802.399700037496, 4823.614110871122, 4843.128236917389, 4905.558499735041, 3603.1532589841368, 3686.3548878946076, 3686.576043754949, 3719.386301260316, 3733.383991641403, 631.3749388105742, 634.2832599163008, 637.4995628431659, 639.523554951564, 653.0922018394435, 803.694596053496, 813.2558708781398, 822.623132042967, 839.7061028639927, 863.5164307987548, 10328.328658637165, 11541.065206570433, 11583.942080289713, 11675.532978680758, 11723.120765942589, 853.5433543054436, 856.5545916123581, 862.0775769926119, 877.8595424732013, 887.4896934262824, 5271.501784752814, 5285.762140703678, 5340.332458442695, 5402.51377376038, 5403.648762830403, 64926.67536662286, 65486.0, 69389.0, 78636.0, 79147.60426197948, 72374.27625723781, 73106.26893730994, 75086.62456687681, 75239.24760752323, 76987.0, 61897.0, 62289.68855155695, 62829.37170628235, 63076.36923630705, 64756.352436475034, 9904.504774761377, 10081.01979040759, 10132.491041486763, 10145.492725363554, 10256.12822910061, 45528.31707524456, 45989.77005114953, 46249.537504624524, 46604.7669761649, 46857.765711171225, 51477.48522514727, 51707.741461292455, 51867.2219916694, 52168.0, 52180.47819521756, 13500.392482338122, 13696.31518424055, 13799.655008624864, 13889.097208681404, 14136.0, 14716.264186790831, 14798.038127521677, 14825.703485930006, 15186.31661575254, 15764.684706305581, 14377.784333235219, 14619.122852628876, 14802.62993425173, 15441.073535587451, 15508.457203997807, 13878.167309961435, 13892.93053534726, 13899.305034748424, 14735.26323683833, 14892.0, 13710.794338084737, 13787.172769633855, 13861.930690346484, 13889.513867014606, 14187.432502699776, 9840.311178217456, 10031.849522257025, 10339.63811266602, 10413.53139108757, 10464.63373781914, 11484.310941343547, 11494.540218391505, 11636.883631163919, 11716.77828342063, 11749.530018799152], "value": 7925.892877221769, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 112.0, 114.0, 112.0, 115.0, 112.0, 111.0, 114.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 114.0, 116.0, 156.0, 122.0, 115.0, 114.0, 121.0, 139.0, 115.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 165.0, 165.0, 161.0, 162.0, 160.0, 160.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 123.0, 75.0, 77.0, 75.0, 75.0, 97.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 111.0, 82.0, 84.0, 82.0, 102.0, 83.0, 82.0, 99.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 113.0, 112.0, 112.0, 113.0, 113.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 80.0, 75.0, 81.0, 86.0, 79.0, 76.0, 79.0, 79.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 139.0, 129.0, 132.0, 131.0, 121.0, 120.0, 118.0, 163.0, 138.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 158.0, 159.0, 158.0, 160.0, 157.0, 156.0, 156.0, 162.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 60.0, 64.0, 58.0, 59.0, 59.0, 62.0], "value": 60.0, "unit": "score"}]}]} 22:09:22 INFO - Return code: 0 22:09:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:09:22 ERROR - # TBPL SUCCESS # 22:09:22 INFO - Running post-action listener: _resource_record_post_action 22:09:22 INFO - [mozharness: 2017-04-18 05:09:22.890929Z] Finished run-tests step (success) 22:09:22 INFO - Running post-run listener: _resource_record_post_run 22:09:22 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 266240; Write bytes: 365760512; Read time: 40; Write time: 224324 22:09:22 INFO - TinderboxPrint: CPU usage
13.1% 22:09:22 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 40 22:09:22 INFO - TinderboxPrint: I/O write bytes / time
365,760,512 / 224,324 22:09:22 INFO - TinderboxPrint: CPU idle
8,278.6 (86.9%) 22:09:22 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 22:09:22 INFO - TinderboxPrint: Swap in / out
0 / 0 22:09:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110731264; Read time: 0; Write time: 88168 22:09:22 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 266240; Write bytes: 255029248; Read time: 40; Write time: 136156 22:09:23 INFO - Running post-run listener: _upload_blobber_files 22:09:23 INFO - Blob upload gear active. 22:09:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:09:23 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 22:09:23 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'] 22:09:23 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 22:09:23 INFO - (blobuploader) - INFO - Open directory for files ... 22:09:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:09:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:09:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:24 INFO - (blobuploader) - INFO - Done attempting. 22:09:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:09:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:09:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:25 INFO - (blobuploader) - INFO - Done attempting. 22:09:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:09:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:09:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:28 INFO - (blobuploader) - INFO - Done attempting. 22:09:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:09:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:09:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:29 INFO - (blobuploader) - INFO - Done attempting. 22:09:29 INFO - (blobuploader) - INFO - Iteration through files over. 22:09:29 INFO - Return code: 0 22:09:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:09:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:09:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/75008f3740f40014476a32705fb1206417f3cebe15b99e957b302c147001df17eb4cbafdddac0531a755274c903f14d19bf7117dc741f93220d87e96dd5b5659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/50d081523e72ef5db308a450fd215b5f49bbed6756b1befbded8587998ef121a74419840850168a6ea2dc5a613b078aef5649b8a6d7feff59dae55ab040680d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5640e1ab3c14d3d1aa76ece2f1c21e65db298ff70951a7826635d3a3d84a34d690efd5d33ab83167856cae5df9d14df82865546a928642ad390af19da0296f84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/11c91f5fedc27a9ae874e0695c28a31deb445446f61475c81d5f354edf5d1ad98f76149856e2813686d14917e2f185e18ae261cacbf78f78c4dd561cf75a1152"} 22:09:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:09:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:09:29 INFO - Contents: 22:09:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/75008f3740f40014476a32705fb1206417f3cebe15b99e957b302c147001df17eb4cbafdddac0531a755274c903f14d19bf7117dc741f93220d87e96dd5b5659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/50d081523e72ef5db308a450fd215b5f49bbed6756b1befbded8587998ef121a74419840850168a6ea2dc5a613b078aef5649b8a6d7feff59dae55ab040680d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5640e1ab3c14d3d1aa76ece2f1c21e65db298ff70951a7826635d3a3d84a34d690efd5d33ab83167856cae5df9d14df82865546a928642ad390af19da0296f84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/11c91f5fedc27a9ae874e0695c28a31deb445446f61475c81d5f354edf5d1ad98f76149856e2813686d14917e2f185e18ae261cacbf78f78c4dd561cf75a1152"} 22:09:29 INFO - Running post-run listener: copy_logs_to_upload_dir 22:09:29 INFO - Copying logs to upload dir... 22:09:29 INFO - mkdir: /builds/slave/test/build/upload/logs 22:09:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.947461 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-17 22:09:29.583316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 22:09:29.586762) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/75008f3740f40014476a32705fb1206417f3cebe15b99e957b302c147001df17eb4cbafdddac0531a755274c903f14d19bf7117dc741f93220d87e96dd5b5659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/50d081523e72ef5db308a450fd215b5f49bbed6756b1befbded8587998ef121a74419840850168a6ea2dc5a613b078aef5649b8a6d7feff59dae55ab040680d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5640e1ab3c14d3d1aa76ece2f1c21e65db298ff70951a7826635d3a3d84a34d690efd5d33ab83167856cae5df9d14df82865546a928642ad390af19da0296f84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/11c91f5fedc27a9ae874e0695c28a31deb445446f61475c81d5f354edf5d1ad98f76149856e2813686d14917e2f185e18ae261cacbf78f78c4dd561cf75a1152"} build_url:https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/PsEQWFcwQx-61SHySMB4TQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/75008f3740f40014476a32705fb1206417f3cebe15b99e957b302c147001df17eb4cbafdddac0531a755274c903f14d19bf7117dc741f93220d87e96dd5b5659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/50d081523e72ef5db308a450fd215b5f49bbed6756b1befbded8587998ef121a74419840850168a6ea2dc5a613b078aef5649b8a6d7feff59dae55ab040680d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5640e1ab3c14d3d1aa76ece2f1c21e65db298ff70951a7826635d3a3d84a34d690efd5d33ab83167856cae5df9d14df82865546a928642ad390af19da0296f84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/11c91f5fedc27a9ae874e0695c28a31deb445446f61475c81d5f354edf5d1ad98f76149856e2813686d14917e2f185e18ae261cacbf78f78c4dd561cf75a1152"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 22:09:29.612098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 22:09:29.612462) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1492490915.686214-875741508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 22:09:29.696169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 22:09:29.696499) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 22:09:29.696778) ========= ========= Total master_lag: 0.17 =========