builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1490813366.06 results: success (0) revision: 4c7c05a49f3ce40aa0969beccb397380a8907f4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:26.064102) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:26.064620) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:26.064902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:26.080027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:26.080447) ========= 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=41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-29 11:49:26-- 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-03-29 11:49:26 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.340671 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:26.435509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:26.435864) ========= 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=41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016660 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:26.485416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:26.485759) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4c7c05a49f3ce40aa0969beccb397380a8907f4a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 4c7c05a49f3ce40aa0969beccb397380a8907f4a --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=41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-29 11:49:26,557 truncating revision to first 12 chars 2017-03-29 11:49:26,557 Setting DEBUG logging. 2017-03-29 11:49:26,557 attempt 1/10 2017-03-29 11:49:26,557 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4c7c05a49f3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 11:49:26,849 unpacking tar archive at: mozilla-central-4c7c05a49f3c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.599938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:27.100574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:27.101104) ========= script_repo_revision: 4c7c05a49f3ce40aa0969beccb397380a8907f4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:27.101522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:27.101799) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:27.112310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-29 11:49:27.112688) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:49:27 INFO - MultiFileLogger online at 20170329 11:49:27 in /builds/slave/test 11:49:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:49:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:27 INFO - {'append_to_log': False, 11:49:27 INFO - 'base_work_dir': '/builds/slave/test', 11:49:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:49:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:27 INFO - 'branch': 'Firefox-Non-PGO', 11:49:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:27 INFO - 'config_files': ('talos/linux_config.py',), 11:49:27 INFO - 'default_actions': ('clobber', 11:49:27 INFO - 'read-buildbot-config', 11:49:27 INFO - 'download-and-extract', 11:49:27 INFO - 'populate-webroot', 11:49:27 INFO - 'create-virtualenv', 11:49:27 INFO - 'install', 11:49:27 INFO - 'run-tests'), 11:49:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:27 INFO - 'download_minidump_stackwalk': True, 11:49:27 INFO - 'download_symbols': 'ondemand', 11:49:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:27 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:27 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:27 INFO - 'gecko_profile': False, 11:49:27 INFO - 'gecko_profile_interval': 0, 11:49:27 INFO - 'installer_path': 'installer.exe', 11:49:27 INFO - 'log_level': 'info', 11:49:27 INFO - 'log_name': 'talos', 11:49:27 INFO - 'log_to_console': True, 11:49:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:49:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:49:27 INFO - 'opt_config_files': (), 11:49:27 INFO - 'pip_index': False, 11:49:27 INFO - 'suite': 'dromaeojs', 11:49:27 INFO - 'system_bits': '32', 11:49:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:27 INFO - 'title': 'talos-linux64-ix-026', 11:49:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:27 INFO - 'use_talos_json': True, 11:49:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:27 INFO - 'work_dir': 'build'} 11:49:27 INFO - [mozharness: 2017-03-29 18:49:27.290370Z] Running clobber step. 11:49:27 INFO - Running pre-action listener: _resource_record_pre_action 11:49:27 INFO - Running main action method: clobber 11:49:27 INFO - rmtree: /builds/slave/test/build 11:49:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:28 INFO - Running post-action listener: _resource_record_post_action 11:49:28 INFO - [mozharness: 2017-03-29 18:49:28.226818Z] Finished clobber step (success) 11:49:28 INFO - [mozharness: 2017-03-29 18:49:28.226917Z] Running read-buildbot-config step. 11:49:28 INFO - Running pre-action listener: _resource_record_pre_action 11:49:28 INFO - Running main action method: read_buildbot_config 11:49:28 INFO - Using buildbot properties: 11:49:28 INFO - { 11:49:28 INFO - "project": "", 11:49:28 INFO - "product": "firefox", 11:49:28 INFO - "who": "kwierso@gmail.com", 11:49:28 INFO - "installer_path": "public/build/target.tar.bz2", 11:49:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:49:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:49:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 11:49:28 INFO - "stage_platform": "linux64", 11:49:28 INFO - "basedir": "/builds/slave/test", 11:49:28 INFO - "buildnumber": 905, 11:49:28 INFO - "platform": "ubuntu64_hw", 11:49:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:49:28 INFO - "slavebuilddir": "test", 11:49:28 INFO - "taskId": "BWkCV2dWTaaBCEapTQPcRw", 11:49:28 INFO - "branch": "mozilla-central", 11:49:28 INFO - "script_repo_revision": "production", 11:49:28 INFO - "revision": "4c7c05a49f3ce40aa0969beccb397380a8907f4a", 11:49:28 INFO - "slavename": "talos-linux64-ix-026", 11:49:28 INFO - "repo_path": "mozilla-central" 11:49:28 INFO - } 11:49:28 INFO - Finding installer, test and symbols from parent task. 11:49:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWkCV2dWTaaBCEapTQPcRw'}, attempt #1 11:49:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWkCV2dWTaaBCEapTQPcRw'}, attempt #1 11:49:29 INFO - Task dependencies: dkptLtbpSxq5ska9dxYCFw 11:49:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw'}, attempt #1 11:49:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 11:49:29 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/test_packages.json 11:49:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.crashreporter-symbols.zip 11:49:29 INFO - Running post-action listener: _resource_record_post_action 11:49:29 INFO - [mozharness: 2017-03-29 18:49:29.603527Z] Finished read-buildbot-config step (success) 11:49:29 INFO - [mozharness: 2017-03-29 18:49:29.603744Z] Running download-and-extract step. 11:49:29 INFO - Running pre-action listener: _resource_record_pre_action 11:49:29 INFO - Running main action method: download_and_extract 11:49:29 INFO - mkdir: /builds/slave/test/build/tests 11:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:29 INFO - trying https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.test_packages.json 11:49:29 INFO - Downloading https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:49:30 INFO - Downloaded 986 bytes. 11:49:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:49:30 INFO - Using the following test package requirements: 11:49:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:49:30 INFO - u'common': [u'target.common.tests.zip'], 11:49:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:49:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:49:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:49:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:49:30 INFO - u'mozbase': [u'target.common.tests.zip'], 11:49:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:49:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:49:30 INFO - u'web-platform': [u'target.common.tests.zip', 11:49:30 INFO - u'target.web-platform.tests.zip'], 11:49:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:49:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:49:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip 11:49:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:49:30 INFO - Fetch https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip into memory 11:49:31 INFO - Expected file size: 58224462 11:49:31 INFO - Obtained file size: 58224462 11:49:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:49:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip 11:49:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:49:40 INFO - Fetch https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip into memory 11:49:42 INFO - Expected file size: 58224462 11:49:42 INFO - Obtained file size: 58224462 11:49:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.talos.tests.zip 11:49:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:49:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.talos.tests.zip into memory 11:49:53 INFO - Expected file size: 14404171 11:49:53 INFO - Obtained file size: 14404171 11:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:53 INFO - trying https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 11:49:53 INFO - Downloading https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:49:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:49:55 INFO - Downloaded 62494062 bytes. 11:49:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 11:49:55 INFO - mkdir: /builds/slave/test/properties 11:49:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:55 INFO - Contents: 11:49:55 INFO - build_url:https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 11:49:55 INFO - Running post-action listener: _resource_record_post_action 11:49:55 INFO - Running post-action listener: set_extra_try_arguments 11:49:55 INFO - [mozharness: 2017-03-29 18:49:55.014436Z] Finished download-and-extract step (success) 11:49:55 INFO - [mozharness: 2017-03-29 18:49:55.014532Z] Running populate-webroot step. 11:49:55 INFO - Running pre-action listener: _resource_record_pre_action 11:49:55 INFO - Running main action method: populate_webroot 11:49:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:55 INFO - '--tppagecycles', 11:49:55 INFO - '7'], 11:49:55 INFO - 'tests': ['tsvgm']}}, 11:49:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:49:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:49:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:49:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:49:55 INFO - 'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:49:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:49:55 INFO - 'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['damp', 'tps']}, 11:49:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:49:55 INFO - 'tests': ['damp', 'tps']}, 11:49:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['dromaeo_dom']}, 11:49:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['basic_compositor_video']}, 11:49:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:49:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['a11yr', 11:49:55 INFO - 'ts_paint', 11:49:55 INFO - 'tpaint', 11:49:55 INFO - 'sessionrestore', 11:49:55 INFO - 'sessionrestore_no_auto_restore', 11:49:55 INFO - 'tabpaint']}, 11:49:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:49:55 INFO - 'ts_paint', 11:49:55 INFO - 'tpaint', 11:49:55 INFO - 'sessionrestore', 11:49:55 INFO - 'sessionrestore_no_auto_restore', 11:49:55 INFO - 'tabpaint']}, 11:49:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:49:55 INFO - 'ts_paint', 11:49:55 INFO - 'tpaint', 11:49:55 INFO - 'sessionrestore', 11:49:55 INFO - 'sessionrestore_no_auto_restore', 11:49:55 INFO - 'tabpaint']}, 11:49:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:49:55 INFO - 'ts_paint', 11:49:55 INFO - 'tpaint', 11:49:55 INFO - 'sessionrestore', 11:49:55 INFO - 'sessionrestore_no_auto_restore', 11:49:55 INFO - 'tabpaint']}, 11:49:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['a11yr', 11:49:55 INFO - 'ts_paint', 11:49:55 INFO - 'tpaint', 11:49:55 INFO - 'sessionrestore', 11:49:55 INFO - 'sessionrestore_no_auto_restore', 11:49:55 INFO - 'tabpaint']}, 11:49:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['a11yr', 11:49:55 INFO - 'ts_paint', 11:49:55 INFO - 'tpaint', 11:49:55 INFO - 'sessionrestore', 11:49:55 INFO - 'sessionrestore_no_auto_restore', 11:49:55 INFO - 'tabpaint']}, 11:49:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['tsvgx', 11:49:55 INFO - 'tsvgr_opacity', 11:49:55 INFO - 'tart', 11:49:55 INFO - 'tscrollx', 11:49:55 INFO - 'cart', 11:49:55 INFO - 'tsvg_static']}, 11:49:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:49:55 INFO - 'tsvgr_opacity', 11:49:55 INFO - 'tart', 11:49:55 INFO - 'tscrollx', 11:49:55 INFO - 'cart', 11:49:55 INFO - 'tsvg_static']}, 11:49:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:49:55 INFO - 'talos_options': ['--disable-e10s'], 11:49:55 INFO - 'tests': ['tp5o']}, 11:49:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:49:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:49:55 INFO - 'talos_options': ['--disable-e10s', 11:49:55 INFO - '--xperf_path', 11:49:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:55 INFO - 'tests': ['tp5n']}, 11:49:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:49:55 INFO - 'talos_options': ['--xperf_path', 11:49:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:55 INFO - 'tests': ['tp5n']}}, 11:49:55 INFO - 'talos.zip': {'path': '', 11:49:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:55 INFO - Running post-action listener: _resource_record_post_action 11:49:55 INFO - [mozharness: 2017-03-29 18:49:55.027522Z] Finished populate-webroot step (success) 11:49:55 INFO - [mozharness: 2017-03-29 18:49:55.027610Z] Running create-virtualenv step. 11:49:55 INFO - Running pre-action listener: _resource_record_pre_action 11:49:55 INFO - Running main action method: create_virtualenv 11:49:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:55 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 11:49:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:55 INFO - Using real prefix '/usr' 11:49:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:57 INFO - Installing pip.................done. 11:49:57 INFO - Return code: 0 11:49:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:49:57 INFO - Reading from file tmpfile_stdout 11:49:57 INFO - Output received: 11:49:57 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) 11:49:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:57 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')]} 11:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:57 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')]} 11:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:57 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 0xae01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, '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': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', '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 11:49:57 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 11:49:57 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 11:49:57 INFO - Using env: {'DISPLAY': ':0', 11:49:57 INFO - 'HOME': '/home/cltbld', 11:49:57 INFO - 'LANG': 'en_US.UTF-8', 11:49:57 INFO - 'LANGUAGE': 'en_US:en', 11:49:57 INFO - 'LOGNAME': 'cltbld', 11:49:57 INFO - 'MAIL': '/var/mail/cltbld', 11:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:57 INFO - 'MOZ_NO_REMOTE': '1', 11:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:57 INFO - 'NO_EM_RESTART': '1', 11:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:57 INFO - 'PWD': '/builds/slave/test', 11:49:57 INFO - 'SHELL': '/bin/bash', 11:49:57 INFO - 'SHLVL': '1', 11:49:57 INFO - 'TERM': 'linux', 11:49:57 INFO - 'TMOUT': '86400', 11:49:57 INFO - 'USER': 'cltbld', 11:49:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:57 INFO - '_': '/tools/buildbot/bin/python'} 11:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:58 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 11:49:58 INFO - Cleaning up... 11:49:58 INFO - Return code: 0 11:49:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:49:58 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')]} 11:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:58 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')]} 11:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:58 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 0xae01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, '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': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', '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 11:49:58 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 11:49:58 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 11:49:58 INFO - Using env: {'DISPLAY': ':0', 11:49:58 INFO - 'HOME': '/home/cltbld', 11:49:58 INFO - 'LANG': 'en_US.UTF-8', 11:49:58 INFO - 'LANGUAGE': 'en_US:en', 11:49:58 INFO - 'LOGNAME': 'cltbld', 11:49:58 INFO - 'MAIL': '/var/mail/cltbld', 11:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:58 INFO - 'MOZ_NO_REMOTE': '1', 11:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:58 INFO - 'NO_EM_RESTART': '1', 11:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:58 INFO - 'PWD': '/builds/slave/test', 11:49:58 INFO - 'SHELL': '/bin/bash', 11:49:58 INFO - 'SHLVL': '1', 11:49:58 INFO - 'TERM': 'linux', 11:49:58 INFO - 'TMOUT': '86400', 11:49:58 INFO - 'USER': 'cltbld', 11:49:58 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:58 INFO - '_': '/tools/buildbot/bin/python'} 11:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:58 INFO - Downloading/unpacking psutil>=3.1.1 11:49:58 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 11:49:58 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 11:49:58 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 11:49:58 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 11:49:58 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 11:49:58 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 11:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:50:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:00 INFO - Installing collected packages: psutil 11:50:00 INFO - Running setup.py install for psutil 11:50:00 INFO - building 'psutil._psutil_linux' extension 11:50:00 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 11:50:00 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 11:50:00 INFO - building 'psutil._psutil_posix' extension 11:50:00 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 11:50:00 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 11:50:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:00 INFO - Successfully installed psutil 11:50:00 INFO - Cleaning up... 11:50:00 INFO - Return code: 0 11:50:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:00 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 0xae01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, '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': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', '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 11:50:00 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 11:50:00 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 11:50:00 INFO - Using env: {'DISPLAY': ':0', 11:50:00 INFO - 'HOME': '/home/cltbld', 11:50:00 INFO - 'LANG': 'en_US.UTF-8', 11:50:00 INFO - 'LANGUAGE': 'en_US:en', 11:50:00 INFO - 'LOGNAME': 'cltbld', 11:50:00 INFO - 'MAIL': '/var/mail/cltbld', 11:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:00 INFO - 'MOZ_NO_REMOTE': '1', 11:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:00 INFO - 'NO_EM_RESTART': '1', 11:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:00 INFO - 'PWD': '/builds/slave/test', 11:50:00 INFO - 'SHELL': '/bin/bash', 11:50:00 INFO - 'SHLVL': '1', 11:50:00 INFO - 'TERM': 'linux', 11:50:00 INFO - 'TMOUT': '86400', 11:50:00 INFO - 'USER': 'cltbld', 11:50:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:00 INFO - '_': '/tools/buildbot/bin/python'} 11:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:50:03 INFO - Installing collected packages: mozsystemmonitor 11:50:03 INFO - Running setup.py install for mozsystemmonitor 11:50:03 INFO - Successfully installed mozsystemmonitor 11:50:03 INFO - Cleaning up... 11:50:03 INFO - Return code: 0 11:50:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:03 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 0xae01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, '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': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', '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 11:50:03 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 11:50:03 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 11:50:03 INFO - Using env: {'DISPLAY': ':0', 11:50:03 INFO - 'HOME': '/home/cltbld', 11:50:03 INFO - 'LANG': 'en_US.UTF-8', 11:50:03 INFO - 'LANGUAGE': 'en_US:en', 11:50:03 INFO - 'LOGNAME': 'cltbld', 11:50:03 INFO - 'MAIL': '/var/mail/cltbld', 11:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:03 INFO - 'MOZ_NO_REMOTE': '1', 11:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:03 INFO - 'NO_EM_RESTART': '1', 11:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:03 INFO - 'PWD': '/builds/slave/test', 11:50:03 INFO - 'SHELL': '/bin/bash', 11:50:03 INFO - 'SHLVL': '1', 11:50:03 INFO - 'TERM': 'linux', 11:50:03 INFO - 'TMOUT': '86400', 11:50:03 INFO - 'USER': 'cltbld', 11:50:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:03 INFO - '_': '/tools/buildbot/bin/python'} 11:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:03 INFO - Downloading/unpacking jsonschema==2.5.1 11:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:03 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 11:50:03 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 11:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:50:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:50:05 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 11:50:05 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 11:50:05 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 11:50:05 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 11:50:05 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 11:50:05 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 11:50:06 INFO - Downloading functools32-3.2.3-2.tar.gz 11:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:50:06 INFO - warning: no files found matching '*.txt' 11:50:06 INFO - no previously-included directories found matching 'build' 11:50:06 INFO - no previously-included directories found matching 'dist' 11:50:06 INFO - no previously-included directories found matching '.git*' 11:50:06 INFO - Installing collected packages: jsonschema, functools32 11:50:06 INFO - Running setup.py install for functools32 11:50:06 INFO - warning: no files found matching '*.txt' 11:50:06 INFO - no previously-included directories found matching 'build' 11:50:06 INFO - no previously-included directories found matching 'dist' 11:50:06 INFO - no previously-included directories found matching '.git*' 11:50:06 INFO - Successfully installed jsonschema functools32 11:50:06 INFO - Cleaning up... 11:50:06 INFO - Return code: 0 11:50:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:06 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 0xae01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, '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': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', '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 11:50:06 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 11:50:06 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 11:50:06 INFO - Using env: {'DISPLAY': ':0', 11:50:06 INFO - 'HOME': '/home/cltbld', 11:50:06 INFO - 'LANG': 'en_US.UTF-8', 11:50:06 INFO - 'LANGUAGE': 'en_US:en', 11:50:06 INFO - 'LOGNAME': 'cltbld', 11:50:06 INFO - 'MAIL': '/var/mail/cltbld', 11:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:06 INFO - 'MOZ_NO_REMOTE': '1', 11:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:06 INFO - 'NO_EM_RESTART': '1', 11:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:06 INFO - 'PWD': '/builds/slave/test', 11:50:06 INFO - 'SHELL': '/bin/bash', 11:50:06 INFO - 'SHLVL': '1', 11:50:06 INFO - 'TERM': 'linux', 11:50:06 INFO - 'TMOUT': '86400', 11:50:06 INFO - 'USER': 'cltbld', 11:50:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:06 INFO - '_': '/tools/buildbot/bin/python'} 11:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:50:06 INFO - Cleaning up... 11:50:06 INFO - Return code: 0 11:50:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:06 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 0xae01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, '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': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', '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 11:50:06 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 11:50:06 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 11:50:06 INFO - Using env: {'DISPLAY': ':0', 11:50:06 INFO - 'HOME': '/home/cltbld', 11:50:06 INFO - 'LANG': 'en_US.UTF-8', 11:50:06 INFO - 'LANGUAGE': 'en_US:en', 11:50:06 INFO - 'LOGNAME': 'cltbld', 11:50:06 INFO - 'MAIL': '/var/mail/cltbld', 11:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:06 INFO - 'MOZ_NO_REMOTE': '1', 11:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:06 INFO - 'NO_EM_RESTART': '1', 11:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:06 INFO - 'PWD': '/builds/slave/test', 11:50:06 INFO - 'SHELL': '/bin/bash', 11:50:06 INFO - 'SHLVL': '1', 11:50:06 INFO - 'TERM': 'linux', 11:50:06 INFO - 'TMOUT': '86400', 11:50:06 INFO - 'USER': 'cltbld', 11:50:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:06 INFO - '_': '/tools/buildbot/bin/python'} 11:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:06 INFO - Downloading/unpacking blobuploader==1.2.4 11:50:06 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 11:50:06 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 11:50:06 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 11:50:06 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 11:50:06 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 11:50:06 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 11:50:08 INFO - Downloading blobuploader-1.2.4.tar.gz 11:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:50:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:50:08 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 11:50:08 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 11:50:08 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 11:50:08 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 11:50:08 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 11:50:08 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 11:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:50:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:50: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 11:50: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 11:50: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 11:50: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 11:50: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 11:50: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 11:50:09 INFO - Downloading docopt-0.6.1.tar.gz 11:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:50:09 INFO - Installing collected packages: blobuploader, requests, docopt 11:50:09 INFO - Running setup.py install for blobuploader 11:50:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:50:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:50:09 INFO - Running setup.py install for requests 11:50:09 INFO - Running setup.py install for docopt 11:50:10 INFO - Successfully installed blobuploader requests docopt 11:50:10 INFO - Cleaning up... 11:50:10 INFO - Return code: 0 11:50:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:10 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')]} 11:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:10 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')]} 11:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:10 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 0xae01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, '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': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', '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 11:50:10 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 11:50:10 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 11:50:10 INFO - Using env: {'DISPLAY': ':0', 11:50:10 INFO - 'HOME': '/home/cltbld', 11:50:10 INFO - 'LANG': 'en_US.UTF-8', 11:50:10 INFO - 'LANGUAGE': 'en_US:en', 11:50:10 INFO - 'LOGNAME': 'cltbld', 11:50:10 INFO - 'MAIL': '/var/mail/cltbld', 11:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:10 INFO - 'MOZ_NO_REMOTE': '1', 11:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:10 INFO - 'NO_EM_RESTART': '1', 11:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:10 INFO - 'PWD': '/builds/slave/test', 11:50:10 INFO - 'SHELL': '/bin/bash', 11:50:10 INFO - 'SHLVL': '1', 11:50:10 INFO - 'TERM': 'linux', 11:50:10 INFO - 'TMOUT': '86400', 11:50:10 INFO - 'USER': 'cltbld', 11:50:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:10 INFO - '_': '/tools/buildbot/bin/python'} 11:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:10 INFO - Running setup.py (path:/tmp/pip-1gtZwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:10 INFO - Running setup.py (path:/tmp/pip-3FfBUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:10 INFO - Running setup.py (path:/tmp/pip-pxhgan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:10 INFO - Running setup.py (path:/tmp/pip-5mJs_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:10 INFO - Running setup.py (path:/tmp/pip-qIDN_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:10 INFO - Running setup.py (path:/tmp/pip-2boTfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:10 INFO - Running setup.py (path:/tmp/pip-RcMd2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:10 INFO - Running setup.py (path:/tmp/pip-otYBoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:10 INFO - Running setup.py (path:/tmp/pip-cbZUjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:11 INFO - Running setup.py (path:/tmp/pip-0rxrVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:11 INFO - Running setup.py (path:/tmp/pip-2XnNjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:11 INFO - Running setup.py (path:/tmp/pip-pJNCP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:11 INFO - Running setup.py (path:/tmp/pip-7U12IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:11 INFO - Running setup.py (path:/tmp/pip-Yd8mxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:11 INFO - Running setup.py (path:/tmp/pip-6bDs7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:11 INFO - Running setup.py (path:/tmp/pip-8TkigI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:11 INFO - Running setup.py (path:/tmp/pip-tDGjUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:50:11 INFO - Running setup.py install for manifestparser 11:50:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:50:11 INFO - Running setup.py install for mozcrash 11:50:11 INFO - Running setup.py install for mozdebug 11:50:11 INFO - Running setup.py install for mozdevice 11:50:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Running setup.py install for mozfile 11:50:12 INFO - Running setup.py install for mozhttpd 11:50:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Running setup.py install for mozinfo 11:50:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Running setup.py install for mozInstall 11:50:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Running setup.py install for mozleak 11:50:12 INFO - Running setup.py install for mozlog 11:50:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Running setup.py install for moznetwork 11:50:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Running setup.py install for mozprocess 11:50:12 INFO - Running setup.py install for mozprofile 11:50:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:50:12 INFO - Running setup.py install for mozrunner 11:50:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:50:13 INFO - Running setup.py install for mozscreenshot 11:50:13 INFO - Running setup.py install for moztest 11:50:13 INFO - Running setup.py install for mozversion 11:50:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:50:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:50:13 INFO - Cleaning up... 11:50:13 INFO - Return code: 0 11:50:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:13 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')]} 11:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:13 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')]} 11:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:13 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 0xae01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, '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': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', '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 11:50:13 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 11:50:13 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 11:50:13 INFO - Using env: {'DISPLAY': ':0', 11:50:13 INFO - 'HOME': '/home/cltbld', 11:50:13 INFO - 'LANG': 'en_US.UTF-8', 11:50:13 INFO - 'LANGUAGE': 'en_US:en', 11:50:13 INFO - 'LOGNAME': 'cltbld', 11:50:13 INFO - 'MAIL': '/var/mail/cltbld', 11:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:13 INFO - 'MOZ_NO_REMOTE': '1', 11:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:13 INFO - 'NO_EM_RESTART': '1', 11:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:13 INFO - 'PWD': '/builds/slave/test', 11:50:13 INFO - 'SHELL': '/bin/bash', 11:50:13 INFO - 'SHLVL': '1', 11:50:13 INFO - 'TERM': 'linux', 11:50:13 INFO - 'TMOUT': '86400', 11:50:13 INFO - 'USER': 'cltbld', 11:50:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:13 INFO - '_': '/tools/buildbot/bin/python'} 11:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:13 INFO - Running setup.py (path:/tmp/pip-dB3UQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:13 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)) 11:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:13 INFO - Running setup.py (path:/tmp/pip-GqaJYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:13 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)) 11:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:13 INFO - Running setup.py (path:/tmp/pip-pzbQ2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:13 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)) 11:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:13 INFO - Running setup.py (path:/tmp/pip-QPFSSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:13 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)) 11:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:13 INFO - Running setup.py (path:/tmp/pip-Heth9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:13 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)) 11:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:13 INFO - Running setup.py (path:/tmp/pip-7Bj4Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:14 INFO - Running setup.py (path:/tmp/pip-ZLhTu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:14 INFO - Running setup.py (path:/tmp/pip-aIUuQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:14 INFO - Running setup.py (path:/tmp/pip-pxHI63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:14 INFO - Running setup.py (path:/tmp/pip-Rfz6vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:14 INFO - Running setup.py (path:/tmp/pip-fIvVFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:14 INFO - Running setup.py (path:/tmp/pip-s5WxIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:14 INFO - Running setup.py (path:/tmp/pip-H0JAU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:14 INFO - Running setup.py (path:/tmp/pip-y6vHVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:14 INFO - Running setup.py (path:/tmp/pip-hkEypS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:14 INFO - Running setup.py (path:/tmp/pip-_WKId0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:14 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)) 11:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:14 INFO - Running setup.py (path:/tmp/pip-3yMV5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:14 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)) 11:50:14 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)) 11:50:14 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)) 11:50:14 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)) 11:50:14 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)) 11:50:14 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)) 11:50:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:50: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 11:50: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 11:50: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 11:50: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 11:50: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 11:50: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 11:50:16 INFO - Downloading blessings-1.6.tar.gz 11:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:50:16 INFO - Installing collected packages: blessings 11:50:16 INFO - Running setup.py install for blessings 11:50:17 INFO - Successfully installed blessings 11:50:17 INFO - Cleaning up... 11:50:17 INFO - Return code: 0 11:50:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:50:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:17 INFO - Reading from file tmpfile_stdout 11:50:17 INFO - Current package versions: 11:50:17 INFO - argparse == 1.2.1 11:50:17 INFO - blessings == 1.6 11:50:17 INFO - blobuploader == 1.2.4 11:50:17 INFO - docopt == 0.6.1 11:50:17 INFO - functools32 == 3.2.3-2 11:50:17 INFO - jsonschema == 2.5.1 11:50:17 INFO - manifestparser == 1.1 11:50:17 INFO - mozInstall == 1.12 11:50:17 INFO - mozcrash == 1.0 11:50:17 INFO - mozdebug == 0.1 11:50:17 INFO - mozdevice == 0.49 11:50:17 INFO - mozfile == 1.2 11:50:17 INFO - mozhttpd == 0.7 11:50:17 INFO - mozinfo == 0.9 11:50:17 INFO - mozleak == 0.1 11:50:17 INFO - mozlog == 3.4 11:50:17 INFO - moznetwork == 0.27 11:50:17 INFO - mozprocess == 0.25 11:50:17 INFO - mozprofile == 0.28 11:50:17 INFO - mozrunner == 6.13 11:50:17 INFO - mozscreenshot == 0.1 11:50:17 INFO - mozsystemmonitor == 0.3 11:50:17 INFO - moztest == 0.8 11:50:17 INFO - mozversion == 1.4 11:50:17 INFO - psutil == 3.1.1 11:50:17 INFO - requests == 1.2.3 11:50:17 INFO - wsgiref == 0.1.2 11:50:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50: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')]} 11:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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')]} 11:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:17 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 0xae01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, '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': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', '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 11:50:17 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 11:50:17 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 11:50:17 INFO - Using env: {'DISPLAY': ':0', 11:50:17 INFO - 'HOME': '/home/cltbld', 11:50:17 INFO - 'LANG': 'en_US.UTF-8', 11:50:17 INFO - 'LANGUAGE': 'en_US:en', 11:50:17 INFO - 'LOGNAME': 'cltbld', 11:50:17 INFO - 'MAIL': '/var/mail/cltbld', 11:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:17 INFO - 'MOZ_NO_REMOTE': '1', 11:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:17 INFO - 'NO_EM_RESTART': '1', 11:50:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:17 INFO - 'PWD': '/builds/slave/test', 11:50:17 INFO - 'SHELL': '/bin/bash', 11:50:17 INFO - 'SHLVL': '1', 11:50:17 INFO - 'TERM': 'linux', 11:50:17 INFO - 'TMOUT': '86400', 11:50:17 INFO - 'USER': 'cltbld', 11:50:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:17 INFO - '_': '/tools/buildbot/bin/python'} 11:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:17 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)) 11:50:17 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)) 11:50:17 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)) 11:50:17 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)) 11:50:17 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)) 11:50:17 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)) 11:50:17 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)) 11:50:17 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)) 11:50:17 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)) 11:50:17 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)) 11:50:17 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)) 11:50:17 INFO - Cleaning up... 11:50:17 INFO - Return code: 0 11:50:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:50: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')]} 11:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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')]} 11:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xae01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, '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': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', '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 11:50: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', 'jsonschema'] in /builds/slave/test/build 11:50: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 jsonschema 11:50:17 INFO - Using env: {'DISPLAY': ':0', 11:50:17 INFO - 'HOME': '/home/cltbld', 11:50:17 INFO - 'LANG': 'en_US.UTF-8', 11:50:17 INFO - 'LANGUAGE': 'en_US:en', 11:50:17 INFO - 'LOGNAME': 'cltbld', 11:50:17 INFO - 'MAIL': '/var/mail/cltbld', 11:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:17 INFO - 'MOZ_NO_REMOTE': '1', 11:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:17 INFO - 'NO_EM_RESTART': '1', 11:50:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:17 INFO - 'PWD': '/builds/slave/test', 11:50:17 INFO - 'SHELL': '/bin/bash', 11:50:17 INFO - 'SHLVL': '1', 11:50:17 INFO - 'TERM': 'linux', 11:50:17 INFO - 'TMOUT': '86400', 11:50:17 INFO - 'USER': 'cltbld', 11:50:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:17 INFO - '_': '/tools/buildbot/bin/python'} 11:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:50:17 INFO - Cleaning up... 11:50:17 INFO - Return code: 0 11:50:17 INFO - Running post-action listener: _resource_record_post_action 11:50:17 INFO - Running post-action listener: _start_resource_monitoring 11:50:17 INFO - Starting resource monitoring. 11:50:17 INFO - [mozharness: 2017-03-29 18:50:17.859072Z] Finished create-virtualenv step (success) 11:50:17 INFO - [mozharness: 2017-03-29 18:50:17.859619Z] Running install step. 11:50:17 INFO - Running pre-action listener: _resource_record_pre_action 11:50:17 INFO - Running main action method: install 11:50:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:18 INFO - Reading from file tmpfile_stdout 11:50:18 INFO - Detecting whether we're running mozinstall >=1.0... 11:50:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:50:18 INFO - Reading from file tmpfile_stdout 11:50:18 INFO - Output received: 11:50:18 INFO - Usage: mozinstall [options] installer 11:50:18 INFO - Options: 11:50:18 INFO - -h, --help show this help message and exit 11:50:18 INFO - -d DEST, --destination=DEST 11:50:18 INFO - Directory to install application into. [default: 11:50:18 INFO - "/builds/slave/test"] 11:50:18 INFO - --app=APP Application being installed. [default: firefox] 11:50:18 INFO - mkdir: /builds/slave/test/build/application 11:50:18 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'] 11:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:50:34 INFO - Reading from file tmpfile_stdout 11:50:34 INFO - Output received: 11:50:34 INFO - /builds/slave/test/build/application/firefox/firefox 11:50:34 INFO - Running post-action listener: _resource_record_post_action 11:50:34 INFO - [mozharness: 2017-03-29 18:50:34.195880Z] Finished install step (success) 11:50:34 INFO - [mozharness: 2017-03-29 18:50:34.196152Z] Running run-tests step. 11:50:34 INFO - Running pre-action listener: _resource_record_pre_action 11:50:34 INFO - Running main action method: run_tests 11:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:34 INFO - Python 2.7.3 11:50:34 INFO - Return code: 0 11:50:34 INFO - grabbing minidump binary from tooltool 11:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:34 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 0xd7b290>, '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 0xd7bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7c040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:34 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 11:50:34 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 11:50:34 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 11:50:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:34 INFO - Return code: 0 11:50:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:50:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:34 INFO - ENV: RUST_BACKTRACE is now 1 11:50:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:50:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 11:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 11:50:34 INFO - Using env: {'DISPLAY': ':0', 11:50:34 INFO - 'HOME': '/home/cltbld', 11:50:34 INFO - 'LANG': 'en_US.UTF-8', 11:50:34 INFO - 'LANGUAGE': 'en_US:en', 11:50:34 INFO - 'LOGNAME': 'cltbld', 11:50:34 INFO - 'MAIL': '/var/mail/cltbld', 11:50:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:34 INFO - 'MOZ_NO_REMOTE': '1', 11:50:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:34 INFO - 'NO_EM_RESTART': '1', 11:50:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:34 INFO - 'PWD': '/builds/slave/test', 11:50:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:34 INFO - 'RUST_BACKTRACE': '1', 11:50:34 INFO - 'SHELL': '/bin/bash', 11:50:34 INFO - 'SHLVL': '1', 11:50:34 INFO - 'TERM': 'linux', 11:50:34 INFO - 'TMOUT': '86400', 11:50:34 INFO - 'USER': 'cltbld', 11:50:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894', 11:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:34 INFO - '_': '/tools/buildbot/bin/python'} 11:50:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 11:50:34 INFO - mozversion application_buildid: 20170329182208 11:50:34 INFO - mozversion application_changeset: 4c7c05a49f3ce40aa0969beccb397380a8907f4a 11:50:34 INFO - mozversion application_display_name: Nightly 11:50:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:34 INFO - mozversion application_name: Firefox 11:50:34 INFO - mozversion application_remotingname: firefox 11:50:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:50:34 INFO - mozversion application_vendor: Mozilla 11:50:34 INFO - mozversion application_version: 55.0a1 11:50:34 INFO - mozversion platform_buildid: 20170329182208 11:50:34 INFO - mozversion platform_changeset: 4c7c05a49f3ce40aa0969beccb397380a8907f4a 11:50:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:50:34 INFO - mozversion platform_version: 55.0a1 11:50:34 INFO - using testdate: 1490813434 11:50:34 INFO - actual date: 1490813434 11:50:34 INFO - starting webserver on 'localhost:42509' 11:50:34 INFO - SUITE-START | Running 2 tests 11:50:34 INFO - TEST-START | dromaeo_css 11:50:34 INFO - operating with platform_type : linux_ 11:50:34 INFO - Initialising browser for dromaeo_css test... 11:50:34 INFO - TEST-INFO | started process 9469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDp1LY6/profile http://localhost:42509/getInfo.html) 11:50:38 INFO - PID 9469 | __metrics Screen width/height:1600/1200 11:50:38 INFO - PID 9469 | colorDepth:24 11:50:38 INFO - PID 9469 | Browser inner width/height: 1024/697 11:50:38 INFO - PID 9469 | __metrics 11:50:39 ERROR - PID 9469 | 1490813439585 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 11:50:39 INFO - PID 9469 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:50:39 INFO - PID 9469 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:50:40 INFO - TEST-INFO | 9469: exit 0 11:50:40 INFO - Browser initialized. 11:50:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:40 INFO - TEST-INFO | started process 9560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDp1LY6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:52 INFO - PID 9560 | RSS: Main: 149319680 11:50:52 INFO - PID 9560 | 11:53:59 INFO - PID 9560 | Cycle 1(1): loaded http://localhost:42509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42509/tests/dromaeo/cssquery-ext.html) 11:54:01 INFO - PID 9560 | RSS: Main: 317571072 11:54:01 INFO - PID 9560 | 11:55:42 INFO - PID 9560 | ************************* 11:55:42 INFO - PID 9560 | A coding exception was thrown and uncaught in a Task. 11:55:42 INFO - PID 9560 | 11:55:42 ERROR - PID 9560 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:55:42 INFO - PID 9560 | Full stack: 11:55:42 INFO - PID 9560 | ************************* 11:55:42 INFO - PID 9560 | ************************* 11:55:42 INFO - PID 9560 | A coding exception was thrown and uncaught in a Task. 11:55:42 INFO - PID 9560 | 11:55:42 ERROR - PID 9560 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:55:42 INFO - PID 9560 | Full stack: 11:55:42 INFO - PID 9560 | ************************* 11:55:42 INFO - PID 9560 | ************************* 11:55:42 INFO - PID 9560 | A coding exception was thrown and uncaught in a Task. 11:55:42 INFO - PID 9560 | 11:55:42 ERROR - PID 9560 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:55:42 INFO - PID 9560 | Full stack: 11:55:42 INFO - PID 9560 | ************************* 11:55:42 INFO - PID 9560 | ************************* 11:55:42 INFO - PID 9560 | A coding exception was thrown and uncaught in a Task. 11:55:42 INFO - PID 9560 | 11:55:42 ERROR - PID 9560 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:55:42 INFO - PID 9560 | Full stack: 11:55:42 INFO - PID 9560 | ************************* 11:57:03 INFO - PID 9560 | Cycle 1(1): loaded http://localhost:42509/tests/dromaeo/cssquery-ext.html (next: http://localhost:42509/tests/dromaeo/cssquery-jquery.html) 11:57:04 INFO - PID 9560 | RSS: Main: 235749376 11:57:04 INFO - PID 9560 | 12:00:06 INFO - PID 9560 | Cycle 1(1): loaded http://localhost:42509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42509/tests/dromaeo/cssquery-mootools.html) 12:00:06 INFO - PID 9560 | RSS: Main: 218341376 12:00:06 INFO - PID 9560 | 12:03:08 INFO - PID 9560 | Cycle 1(1): loaded http://localhost:42509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42509/tests/dromaeo/cssquery-prototype.html) 12:03:09 INFO - PID 9560 | RSS: Main: 235798528 12:03:09 INFO - PID 9560 | 12:06:12 INFO - PID 9560 | Cycle 1(1): loaded http://localhost:42509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42509/tests/dromaeo/cssquery-yui.html) 12:06:13 INFO - PID 9560 | RSS: Main: 185163776 12:06:13 INFO - PID 9560 | 12:09:16 INFO - PID 9560 | Cycle 1(1): loaded http://localhost:42509/tests/dromaeo/cssquery-yui.html (next: http://localhost:42509/tests/dromaeo/cssquery-dojo.html) 12:09:16 INFO - PID 9560 | RSS: Main: 276164608 12:09:16 INFO - PID 9560 | 12:09:16 INFO - PID 9560 | __start_tp_report 12:09:16 INFO - PID 9560 | _x_x_mozilla_page_load 12:09:16 INFO - PID 9560 | _x_x_mozilla_page_load_details 12:09:16 INFO - PID 9560 | |i|pagename|runs| 12:09:16 INFO - PID 9560 | |0;dojo.html;2662.227953893371;2697.0964726816514;2728.890844366225;2734.043084920278;2737.603047558104;5136.563392111666;5235.947640523594;5308.780059119599;5312.150055991042;5378.489043540867;5286.3392075990505;5319;5330.546903513206;5364.088105022146;5394.757235924383;4557.977210113945;4821.7830197641015;4937.950620493785;4975.776090075955;4979.526944940225;4892.584130348907;4921.581665558432;4922.55696987271;4924.28597853311;4936.605071594282;4689.413823272091;4742.478327383985;4749.335093086971;4812.975935120337;4851.199552073904;4809.182438985381;4824.228123500223;4856.757162141878;4901.5588597026435;4903.338049363326;4786.377770889797;4786.449558300805;4788.329633851264;4803.3995750531185;4820.349252850855;5110.207917772751;5164.948350516522;5290.795600911508;5297.12597421425;5341.252224688546;5630.577706672016;5644.717764111819;5646.20953066571;5646.350669672999;5650;5666.688332141731;5675.3757086720425;5689.886202275931;5733.340665823442;5742.167385729088;5323.893522129536;5328.467153284718;5329.920051199235;5330.253764472977;5332.573394128461;5703.8859222816145;5761.107028410603;5864.120381942743;5880.441358070976;5887.440693134231;5498.340199176125;5523.917141242885;5607.383187849333;5660.8867822643315;5680.034394153004;5768.798092066758;5768.855778605568;5769.913451298234;5774.942250577525;5807.157962095473;5684.687342196219;5727.083666613322;5733.971330143406;5741.167530708024;5741.425857414309;5458.344998600114;5532.529734972572;5534.418886016991;5535.280413546294;5715.514181294637;4759.738214398172;4810.350602668665;4824.372831531879;4824.565789079;4827.686200396963;4066.6337586445957;4083.6324730773777;4097.692673049533;4111.876643700693;4129.132882094734;4762.285657151455;4769.833055843098;4770.198451402302;4775.2359622460235;4817.012512434942;5516.365617953907;5586.832395028156;5592.832215033555;5706.115552089433;5753.88492230153;4731.976340118277;4762.499937506581;4762.809487620526;4791.736454495036;4805.27920811881;5071.0872043032605;5076.13705670037;5090.160123579568;5105.33630628016;5153.587712982952;5140.151874940593;5391.838244852583;5403.756830942539;5406.459354064562;5415.83752487426;5521.089020311603;5569.969555632221;5576.191452239484;5710.2862142232225;5790.363060063305;5377.435369286325;5377.516023557899;5393.083175860192;5405.891882162414;5435.972820135874;5644.096944488862;5690.203371527907;5692.402297758676;5692.43075692444;5693.231413759255;5544.63959842609;5563.304586926634;5628.915566266591;5648.124540696199;5752.482276595127;5582.86042848932;5607.411221821813;5608.943910560843;5617.943820561905;5618.859528511656;5502.0371434997915;5564.137558678412;5604.159376093618;5604.299462567179;5607.214989901336;5411.78352865881;5421.701806400686;5430.913817236489;5465.371482279589;5465.699386533779;5418.647787893774;5496.532794712494;5605.579581531483;5606.523445507178;5650.745716442852;5307.044731948286;5381.596380271573;5454.8909021818545;5461.371942226695;5469.3983661797965 12:09:16 INFO - PID 9560 | |1;ext.html;573.5698226330252;650.6096342194683;662.4435474201671;1075.397777244743;1089.0470838016736;26934.865325673392;33118.83440582797;33824.83087584559;33855.322893542114;33866.322673546514;35532.11169720758;36013;36026.2794744105;36030.27939441216;36107.27785444296;5679.858003549903;7430.4427167962485;7616.086069671647;7619.047619047591;7624.313811756969;5696.2594862668;7247;7466.626668666572;7481.962590187041;7484.3638290745075;7532.39740820733;7590.58251796151;7592.696292148307;7592.772216833504;7596.354309883666;7498.6625601848045;7561.508501947355;7574.394048476109;7581.090269167735;7582.241775822401;7306.890396644055;7382.18795932447;7392.6303684816085;7399.926000739977;7400.740974065936;33256.33487330264;33478.83260583682;33522.329553408796;33563.16092097693;33591.160220994425;2607.7131515533274;2631.723669014745;2638.4327369615626;2643.458091091322;2689.2201261634104;22066.558668826532;22097.447563810874;22217.333479995625;22305.44236394087;22436.32691019272;2538.0482319130324;2552.8978840846344;2554.0805310088354;2561;2564.192279431973;136897;137520;138003;138305.308473458;138405;39745.40381894274;39847.80076099601;39848.62422012464;39858.60141398549;39864.80405587837;42403.363949540784;42413.15173696509;42425.36361954573;42518.57481425208;42523.787381063514;10997.175211859143;11237.494312755782;11249.775004500028;11249.918765028333;11262;8153.429259951747;8305.543195124326;8695.043545210021;8703.738887833375;8712.085231050774;12581.748365032649;12722.936385318015;12737.808932866015;12857.614271571867;12951;5296.437550922487;5318.361796584357;5361.383440904346;5490.176473529003;5536.557075434036;855.8930133733284;887.5650931043871;895.4985208283382;896.3098414221014;918.6830543462495;20144.194232230548;20710.68933965992;20820.167193312096;20980.370588882357;21142.365729028155;939.9671011514564;952.3428834104445;952.5618215620754;963.5712108111823;974.9317547771587;10403.219758518142;10751.892481075245;10883.401412922365;10978.451077446096;10980.505877235544;234125;234287;235539;235715;235951;41006.1798764029;41603.58396416058;41689.37465938013;41727.79136104361;41782.58217417787;1175.5767923547517;1199.622119032502;1211.0977321895245;1211.4306276050243;1223.0399136677665;18856.811431886053;19203.679172186145;20230.898845506268;20273.59452810965;20761.896190519554;29564;29581.556276655436;29586.260343491584;29594.704052959194;29602.259943500725;213054;213113;213368;213740;213870;22787.430314242276;23376.298711038697;27854.16437506878;28099.578506322014;28134.71865281321;31156;31341.68658313479;32243.516347255278;32261.677383226805;32369.33536631033;23857.40356491032;24400.26799196027;24518.75481245236;25034.874825625757;25167.622485663094;24219.75780242175;24379.634305485786;24760.380990475383;24785.1325203617;25035.248942531754;26385.60421593716;26464.470710586065;26480.470390591694;26648.733512664625;26761.06336278221;23929.401764956016;24506.387340316636;24880.50238995246;24915;24975.375615609755;19941.900290498455;20314.187432502535;20433.386998390073;20510.282140125026;20575.897120514303 12:09:16 INFO - PID 9560 | |2;jquery.html;404.24809853672184;406.81286608160246;426.14770459081825;429.6670080687467;437.70236239357223;17117.486475405727;17858.64282714345;18524.90737546314;18527.72208416873;18530.07349632518;18360.26558937641;18596.07019649019;18822.24711011561;19296.614067718638;19421.12604932778;5701.57238207134;5712.086066229404;5833.562482813784;5866.823995280149;5868.501177399926;5741.827745167651;5852.063669812831;5855.61938474;5856.619319744224;5859.209006784094;5595.944040559583;5671.319441667006;5713.914291285634;5718.857028574277;5719.027765279891;5648.519875810561;5744.396838331978;5782.9421705782825;5798.826035218929;5800.709964501758;5160.380754309469;5210.036143313461;5216.356847592996;5233.2935053768015;5234.555062819665;22373.776262237494;22726.545469090524;22859.428514287276;22874.656880146813;22986;1542.8302886682457;1551.43372668975;1556.0585845563385;1596.9201539922958;1598.2168737318746;13598.524051658145;14444.205568693718;14491.78262326066;14533.927330363385;15007.924960375238;1685.6544408396248;1687.940922067734;1688.8057873344599;1689.4762623586728;1739.965200695979;86222.5688871558;87475.56262218712;90170.5491472545;90445.54777226137;91317.54341228318;10843.295185812896;10994.450277486094;11039.779204416027;11232.943835280772;11436.370999594936;15388;15438.15090170029;15533;15536;15605.843941560666;6957.965210173917;7091.716331346792;7197.964010179916;7246.637668116573;7353.669084891193;6334.778282760173;6441.613503189824;6577.86844263112;6589.439897608757;6599.8020059398295;7037.683304251321;7082.752103676346;7136.678849451787;7169.562348801433;7175.390091842252;1930.758655168104;1936;2021.4036859126593;2030.4111807575637;2068.851787258086;811.9512829230147;822.2312138150849;823.9340852731767;838.1325328285195;840.428508614136;16659.3336266548;16955.51660949594;17260.223289951984;17932.282708691506;18011.18949647269;844.991829088447;855.3584811391456;857.7005836158226;860.4622111180512;866.3199388480012;9371.62513499466;9587.568559414844;9694.418334899929;9721.951390243003;9864.704058878246;401789;406778.9831525295;411782;413410;413962;87576.56211719027;88002;88602;88844.11155888358;89652.31043068718;1042.0985847242082;1078.7411021354976;1092.1699508373692;1098.4123493930708;1099.279971618575;17317.653646926738;17391.913040434716;18062.277508900024;18129.45611631653;18509.35217267443;42970.57029429666;43289.783551082044;43397.78301108474;44153.33769993517;44412.77793611011;55871.72064139653;56247.71876140593;56545.43454565402;57242.7137864308;58004.70997644985;8135.430519863553;8182.4681395709085;8223.17768223173;8274.967702976286;8278.586070696321;13065.934670326587;13389.263590502616;13456.730865382833;13463.798043029557;13499.190048597116;10040.246981476272;10070.647527336509;10073.143782778547;10592.364458132537;11520.711982200512;9243.537823108953;9316.95341523288;9349.719508414759;9534.904650953402;9642.469664168539;10681;10723.463826808784;11092.833607495733;11336.659900203007;11528.654140375802;8348.540830254151;8368.121347258693;8552.144785521397;8633.223009929137;8707.651693932425;9963.800723985334;10008.899911000797;10191.490425478549;10464;11050.889491105308 12:09:16 INFO - PID 9560 | |3;mootools.html;1115.782422427627;1260.6470188347264;1294.857565667777;1312.684955610653;1315.0860152194225;8357.707480238192;9632.518374081294;9865.112139907407;9927.75180620485;9940.602375904955;9703.029697030312;9789.559469823856;9790.608375664982;9800.215982721384;9806.803863922718;1859.4421673497964;2168.27362833451;2200.0759680934048;2202.41635966469;2202.4603972026875;1937.951551211224;2147.5060736030723;2214.4906671465574;2215.9889200553976;2221.1115553778454;2170.8697478151284;2178.2049551913515;2196.242296407737;2197.6483762597986;2198.3404978506464;2153.956920861574;2155.3641675705703;2161.6973623692616;2164.058634494;2202.361315218585;2166.0469393466824;2172.5872084303933;2183.912643494258;2193;2200.922967696139;9716.61133554657;9790.118889299925;9800.215982721365;9811.215102791759;9813.803723925554;4874.951250487486;5037.244413337992;5040.294358789773;5043.747812609392;5045.823396181116;3133.8746450141966;3289.9177520562175;3292;3304.7851889627095;3322.9501557476656;981.5190556627273;1033.5813995331903;1059.5602824827688;1062.8671416072991;1065.589747947046;14465;14489.492867749577;14506;14512.419503219964;14514.491992780202;4909.459959404463;5026.547610715053;5048.545630893237;5086.593072554187;5108.642395032312;12133.69665758363;12139.453724582238;12163.452644631012;12166.635000949986;12174.086943479275;5149.356330458692;5194.065068287745;5230.032443997797;5262.578993680497;5282.418933917266;4480.686351955332;4687.859364219079;4737.95262047382;4761.880952976203;4768.332433459318;3896.844126234919;3980.7810570418906;4008.8596899108393;4029.7985100744845;4137.710360274812;1268.543324403214;1278.5908509276942;1285.479380850757;1290.6450726050412;1315.7894736842252;646.3697894552868;668.9364510371507;671.3018460800713;676.8443258050676;677.1907570453261;4905.828296009694;5223.921641175385;5766.163906233573;5767.769289228468;5839.386864379264;528.2709860392633;532.7283085626359;532.9014132385521;535.7830078818085;538.4588488568963;3222.6455089940087;3241.157299102203;3278.1149089745636;3313.237955270253;3391.6947474727394;12289.262644241375;12693.936530317289;12833.807492887614;12845.550405735754;12853.421596028202;12765.744685106245;12775.488980440678;12778.424970876147;12779.616611501484;12812.974962003018;8821.250193733476;9200.35597508168;9300.581473833558;9312.487813170204;9364.297677674202;5451.373092094302;5469.179623056573;5549.472800083986;5618.550515958632;5674.602777805514;10982.231243813176;11126.554937802397;11179.441027948407;11242.325460472397;11316.717082073013;10228.64199753005;11518.769624607294;11575.363355015555;11626.70933226676;11692.181547291608;6884.690188941409;8118.675252989814;8121.066077400938;8144.389170812331;8146.511209327459;8918.509481978293;9094.772630684285;9234.769130771516;9243.445393276425;9281.907180928105;7560.58416787082;7685.38516918634;7721.112072111779;7770.92229077702;7874.606269686607;7520.586367749826;7559.470837041355;7585.165631780389;7715.22847715224;7899;6335.429811317003;6427.421532062137;6428.774992875227;6428.939225027818;6429.6142231466265;4798.206278026906;4915.361003069578;4941.876453088702;4948.38145231846;4983.601311894967;4706.294055891643;4843.055604157155;4883.291922671264;4929.605631549539;5000 12:09:16 INFO - PID 9560 | |4;prototype.html;367.77014366021234;388.5628667748783;396.8551478710271;397.53289884385856;402.1013035864842;5305.151175811871;5327.2808170896915;5339.305890234274;5356.9732151339285;5371.543418809396;5244.475552444754;5253.921191182126;5254.921176182351;5256.605754568413;5267.39424966129;4144.52337981133;4175.645070169024;4211.599898009684;4221.831126754926;4238.8092535835885;4216.894577635553;4220.240356735786;4237;4240.512341080769;4241.215375155591;4190.161967606491;4193;4199.811008504625;4203.4115223868685;4216.578342165774;4058.3157989434644;4175.185838761443;4217.40956266123;4219.472565929259;4222.239996800575;3775.5846856845724;3780.640839120279;3785.9053523661855;3794.9430758538642;3803.9619603804163;5120.897582048376;5122.154844450662;5133.743312834381;5140.974295128501;5142.177251639757;4694.671373003891;4842.322074909515;4852.126617208901;4857.149998750205;4864.513548645143;5508.20131080995;5514.503694667459;5536.197251398525;5537.833864984057;5542.196381524696;4157.10622216222;4160.188763191179;4182.205380977604;4186.0581369192;4197.727147735418;5345.305110335631;5596.608237423382;5741.25363702716;5833.82498525045;5842.707864606795;4144.109016561454;4246.065865509583;4303.440552728125;4324.654027677778;4337.175936572105;4378.277584198635;4391.033972526039;4397.73613583186;4399.5820397062225;4400.339949007611;4857.368542089576;4864.0028794097125;4866;4871.683340582922;4886.364772579613;5434.592405569598;5493.972530137324;5499.477549632778;5565.7217139143695;5567.638103523258;1505.8720008799376;1525.1764047414495;1526.4275896538797;1526.7328217561883;1528.533797191845;1052.8789189243334;1087.483445363462;1096.3202814255212;1102.9944850275697;1112.3659514076899;4710.505396933341;4712.31671407644;4716.9056618867435;4721.693089949143;4722.598579120745;5647.209390685307;5659.660420374708;5662.365945883872;5665.830025099253;5680.7727690892725;4560;4681.344611754357;4718.381298379432;4721.5986641135205;4722.5513576210205;2954.896578619738;2963.1110666799873;2963.940721185564;2987.5668028135797;2995;5260.63223561869;5287.41838397776;5300.469953004668;5300.893982120336;5317.803494213848;5525.364583072998;5679.716014199274;5765.798197063083;5816.418358164235;5826.82519524415;5167.741612919339;5178.430372659004;5306.257124002643;5333.200019996954;5354.705491198021;5624.634398764068;5650.547956163415;5667.744951477111;5675.177099320493;5679.290088738908;5376.516113549643;5598.076317407582;5611.969536450271;5621.971890140523;5632.380438151718;5338.065838478328;5342.813001544927;5346.465353464622;5354.812581559627;5377.784888604412;4016.0562267867613;4030.314846476165;4032.495938007749;4035.4148648445225;4037.2732908075654;5526.336839579276;5701.258836351413;5724;5726.885462290814;5733.598648094593;5461.9453805461435;5489.643173193889;5506.375619192268;5522.861928451821;5522.944770552243;5356.491133342326;5488.643238189505;5496.422875598005;5508.476694713996;5523.254360661259;5393.919091213556;5408.8377348679605;5411.78352865881;5441.401445840876;5445.455454454681;5523.922835047128;5540.501354878081;5548.280033189724;5564.805231816867;5566.165075238747;5167.534921857051;5348.956953394051;5392.272043274108;5397.8380648580605;5420.728963551728 12:09:16 INFO - PID 9560 | |5;yui.html;659.3999460490954;664.8271449423148;674.5952428542874;682.9453643708504;685.674304705265;10769.461526923662;11093.611723589665;11113.11095112391;11114.277571957817;11146.108311335094;11853.407329633505;11920.821187682192;12049.578264760736;12240.204386714857;12277.263364198154;866.3891956170916;878.8154487557605;910.1399177777004;913.6391125505454;914.5381582300929;927.8144371125768;946.129560804062;946.7017889364828;946.857971304303;947.327397547742;963.2534785541227;979.8677178580872;980.1423754215061;980.9558569864338;981.3523074770653;957.2198658093666;975;975.0980343182528;975.7170420578024;976.6581696406272;711.4415184080524;711.7473296979549;711.900333953247;711.9750808721722;711.9928800711979;13072.477100915952;13337.666558336023;13399.665008374772;13406.329683515884;13494.93252533731;12415.565455209115;13007.739845203043;13630.250336231504;13696.315184240748;13821.272340957381;9547.52262386878;9724.319297649168;9930.851037234448;10062.547185376676;10392.960703929622;2571.434284457416;2593.351662084479;2602.0892687559394;2652.244110428538;2671.6259723638514;56940.43059569434;60146;60266.09600855947;60756;61391.38608613901;10609.734756631146;10612.946935265429;10727.570897164025;10736.516856741466;10861.1854110942;20008.89995550042;20022.799772002385;20194.59610807805;20254.49363765888;20270.594588108157;5874.089516125007;5909.409059094056;5948.226730525091;5972.850678733066;6135.171751813537;3075.815451072943;3169.952450713241;3205.166656669283;3228.2736384313343;3249.8050116993054;3313.519539666735;3388.8644454221553;3397.1846756778195;3441.741869359808;3443.810590417551;665.9766908158288;669.8727241824038;685.8971154326891;685.917689877218;689.9379055884995;504.64422582079544;524.5122036506086;530.6895466152267;547.9671219726829;565.9801906933237;8022.318102961313;8139.593020349077;8259.380546458919;8448.788780280542;8524.232819046316;499.7306840624845;499.7501249375312;517.9171332586768;542.7557599080351;543.0767694918654;3757.1734218471893;3785.337565925952;3826.885193444201;3866.168773713665;4041.373587094005;57954.8409031817;58581.4141858576;59252.81494370088;59811.10283345753;59852;47112.7644361776;50498;51111.23333150006;51194;52208;40378.39432408458;40724.59275407208;41386.79306603448;41890.79054604707;42707.57292427098;9014;9794.706158815246;9870.161036311707;9886.30795844284;9887.110160085627;23813;23865.40336491532;24405.633915490926;24549;24948.251552453454;29104.56343154812;29630.703692962794;29905.401891961603;30538;30921;11163.609273675707;11175.202586723319;11223;11444.198906076828;11530.538778449103;12858.925096062902;12870.613881583567;13010.47958081704;13204.27376494302;13789.862101378858;11669.011433213824;11703.76592468163;11707.765844682888;12051.096167787276;12072.396380181131;11161.609343672932;11366.943165284121;11611.767764644828;11616.303021818718;12122.393880306126;11036.834447483454;11093.667189984313;11185.440727963733;11307.717307067389;11339.149563782914;8918;9022.14289642483;9043.819123617359;9198.954005230198;9343.392679475812;9962.900370996198;10265.178785697275;10272.22958278147;10292.794144116926;10306.381617102998 12:09:16 INFO - PID 9560 | __end_tp_report 12:09:16 INFO - PID 9560 | __start_cc_report 12:09:16 INFO - PID 9560 | _x_x_mozilla_cycle_collect,1788 12:09:16 INFO - PID 9560 | __end_cc_report 12:09:16 INFO - PID 9560 | __startTimestamp1490814556367__endTimestamp 12:09:16 INFO - PID 9560 | 12:09:16 INFO - PID 9560 | ------- Summary: start ------- 12:09:16 INFO - PID 9560 | Number of tests: 6 12:09:16 INFO - PID 9560 | 12:09:16 INFO - PID 9560 | [#0] dojo.html Cycles:165 Average:5223.80 Median:5403.76 stddev:600.99 (11.1%) stddev-sans-first:568.25 12:09:16 INFO - PID 9560 | Values: 2662.2 2697.1 2728.9 2734.0 2737.6 5136.6 5235.9 5308.8 5312.2 5378.5 5286.3 5319.0 5330.5 5364.1 5394.8 4558.0 4821.8 4938.0 4975.8 4979.5 4892.6 4921.6 4922.6 4924.3 4936.6 4689.4 4742.5 4749.3 4813.0 4851.2 4809.2 4824.2 4856.8 4901.6 4903.3 4786.4 4786.4 4788.3 4803.4 4820.3 5110.2 5164.9 5290.8 5297.1 5341.3 5630.6 5644.7 5646.2 5646.4 5650.0 5666.7 5675.4 5689.9 5733.3 5742.2 5323.9 5328.5 5329.9 5330.3 5332.6 5703.9 5761.1 5864.1 5880.4 5887.4 5498.3 5523.9 5607.4 5660.9 5680.0 5768.8 5768.9 5769.9 5774.9 5807.2 5684.7 5727.1 5734.0 5741.2 5741.4 5458.3 5532.5 5534.4 5535.3 5715.5 4759.7 4810.4 4824.4 4824.6 4827.7 4066.6 4083.6 4097.7 4111.9 4129.1 4762.3 4769.8 4770.2 4775.2 4817.0 5516.4 5586.8 5592.8 5706.1 5753.9 4732.0 4762.5 4762.8 4791.7 4805.3 5071.1 5076.1 5090.2 5105.3 5153.6 5140.2 5391.8 5403.8 5406.5 5415.8 5521.1 5570.0 5576.2 5710.3 5790.4 5377.4 5377.5 5393.1 5405.9 5436.0 5644.1 5690.2 5692.4 5692.4 5693.2 5544.6 5563.3 5628.9 5648.1 5752.5 5582.9 5607.4 5608.9 5617.9 5618.9 5502.0 5564.1 5604.2 5604.3 5607.2 5411.8 5421.7 5430.9 5465.4 5465.7 5418.6 5496.5 5605.6 5606.5 5650.7 5307.0 5381.6 5454.9 5461.4 5469.4 12:09:16 INFO - PID 9560 | 12:09:16 INFO - PID 9560 | [#1] ext.html Cycles:180 Average:32712.19 Median:27976.87 stddev:52192.61 (186.6%) stddev-sans-first:52283.24 12:09:16 INFO - PID 9560 | Values: 573.6 650.6 662.4 1075.4 1089.0 26934.9 33118.8 33824.8 33855.3 33866.3 35532.1 36013.0 36026.3 36030.3 36107.3 5679.9 7430.4 7616.1 7619.0 7624.3 5696.3 7247.0 7466.6 7482.0 7484.4 7532.4 7590.6 7592.7 7592.8 7596.4 7498.7 7561.5 7574.4 7581.1 7582.2 7306.9 7382.2 7392.6 7399.9 7400.7 33256.3 33478.8 33522.3 33563.2 33591.2 2607.7 2631.7 2638.4 2643.5 2689.2 22066.6 22097.4 22217.3 22305.4 22436.3 2538.0 2552.9 2554.1 2561.0 2564.2 136897.0 137520.0 138003.0 138305.3 138405.0 39745.4 39847.8 39848.6 39858.6 39864.8 42403.4 42413.2 42425.4 42518.6 42523.8 10997.2 11237.5 11249.8 11249.9 11262.0 8153.4 8305.5 8695.0 8703.7 8712.1 12581.7 12722.9 12737.8 12857.6 12951.0 5296.4 5318.4 5361.4 5490.2 5536.6 855.9 887.6 895.5 896.3 918.7 20144.2 20710.7 20820.2 20980.4 21142.4 940.0 952.3 952.6 963.6 974.9 10403.2 10751.9 10883.4 10978.5 10980.5 234125.0 234287.0 235539.0 235715.0 235951.0 41006.2 41603.6 41689.4 41727.8 41782.6 1175.6 1199.6 1211.1 1211.4 1223.0 18856.8 19203.7 20230.9 20273.6 20761.9 29564.0 29581.6 29586.3 29594.7 29602.3 213054.0 213113.0 213368.0 213740.0 213870.0 22787.4 23376.3 27854.2 28099.6 28134.7 31156.0 31341.7 32243.5 32261.7 32369.3 23857.4 24400.3 24518.8 25034.9 25167.6 24219.8 24379.6 24760.4 24785.1 25035.2 26385.6 26464.5 26480.5 26648.7 26761.1 23929.4 24506.4 24880.5 24915.0 24975.4 19941.9 20314.2 20433.4 20510.3 20575.9 12:09:16 INFO - PID 9560 | 12:09:16 INFO - PID 9560 | [#2] jquery.html Cycles:180 Average:26729.41 Median:21917.74 stddev:68196.72 (311.1%) stddev-sans-first:68359.38 12:09:16 INFO - PID 9560 | Values: 404.2 406.8 426.1 429.7 437.7 17117.5 17858.6 18524.9 18527.7 18530.1 18360.3 18596.1 18822.2 19296.6 19421.1 5701.6 5712.1 5833.6 5866.8 5868.5 5741.8 5852.1 5855.6 5856.6 5859.2 5595.9 5671.3 5713.9 5718.9 5719.0 5648.5 5744.4 5782.9 5798.8 5800.7 5160.4 5210.0 5216.4 5233.3 5234.6 22373.8 22726.5 22859.4 22874.7 22986.0 1542.8 1551.4 1556.1 1596.9 1598.2 13598.5 14444.2 14491.8 14533.9 15007.9 1685.7 1687.9 1688.8 1689.5 1740.0 86222.6 87475.6 90170.5 90445.5 91317.5 10843.3 10994.5 11039.8 11232.9 11436.4 15388.0 15438.2 15533.0 15536.0 15605.8 6958.0 7091.7 7198.0 7246.6 7353.7 6334.8 6441.6 6577.9 6589.4 6599.8 7037.7 7082.8 7136.7 7169.6 7175.4 1930.8 1936.0 2021.4 2030.4 2068.9 812.0 822.2 823.9 838.1 840.4 16659.3 16955.5 17260.2 17932.3 18011.2 845.0 855.4 857.7 860.5 866.3 9371.6 9587.6 9694.4 9722.0 9864.7 401789.0 406779.0 411782.0 413410.0 413962.0 87576.6 88002.0 88602.0 88844.1 89652.3 1042.1 1078.7 1092.2 1098.4 1099.3 17317.7 17391.9 18062.3 18129.5 18509.4 42970.6 43289.8 43397.8 44153.3 44412.8 55871.7 56247.7 56545.4 57242.7 58004.7 8135.4 8182.5 8223.2 8275.0 8278.6 13065.9 13389.3 13456.7 13463.8 13499.2 10040.2 10070.6 10073.1 10592.4 11520.7 9243.5 9317.0 9349.7 9534.9 9642.5 10681.0 10723.5 11092.8 11336.7 11528.7 8348.5 8368.1 8552.1 8633.2 8707.7 9963.8 10008.9 10191.5 10464.0 11050.9 12:09:16 INFO - PID 9560 | 12:09:16 INFO - PID 9560 | [#3] mootools.html Cycles:180 Average:6076.17 Median:4820.63 stddev:3937.84 (81.7%) stddev-sans-first:3931.24 12:09:16 INFO - PID 9560 | Values: 1115.8 1260.6 1294.9 1312.7 1315.1 8357.7 9632.5 9865.1 9927.8 9940.6 9703.0 9789.6 9790.6 9800.2 9806.8 1859.4 2168.3 2200.1 2202.4 2202.5 1938.0 2147.5 2214.5 2216.0 2221.1 2170.9 2178.2 2196.2 2197.6 2198.3 2154.0 2155.4 2161.7 2164.1 2202.4 2166.0 2172.6 2183.9 2193.0 2200.9 9716.6 9790.1 9800.2 9811.2 9813.8 4875.0 5037.2 5040.3 5043.7 5045.8 3133.9 3289.9 3292.0 3304.8 3323.0 981.5 1033.6 1059.6 1062.9 1065.6 14465.0 14489.5 14506.0 14512.4 14514.5 4909.5 5026.5 5048.5 5086.6 5108.6 12133.7 12139.5 12163.5 12166.6 12174.1 5149.4 5194.1 5230.0 5262.6 5282.4 4480.7 4687.9 4738.0 4761.9 4768.3 3896.8 3980.8 4008.9 4029.8 4137.7 1268.5 1278.6 1285.5 1290.6 1315.8 646.4 668.9 671.3 676.8 677.2 4905.8 5223.9 5766.2 5767.8 5839.4 528.3 532.7 532.9 535.8 538.5 3222.6 3241.2 3278.1 3313.2 3391.7 12289.3 12693.9 12833.8 12845.6 12853.4 12765.7 12775.5 12778.4 12779.6 12813.0 8821.3 9200.4 9300.6 9312.5 9364.3 5451.4 5469.2 5549.5 5618.6 5674.6 10982.2 11126.6 11179.4 11242.3 11316.7 10228.6 11518.8 11575.4 11626.7 11692.2 6884.7 8118.7 8121.1 8144.4 8146.5 8918.5 9094.8 9234.8 9243.4 9281.9 7560.6 7685.4 7721.1 7770.9 7874.6 7520.6 7559.5 7585.2 7715.2 7899.0 6335.4 6427.4 6428.8 6428.9 6429.6 4798.2 4915.4 4941.9 4948.4 4983.6 4706.3 4843.1 4883.3 4929.6 5000.0 12:09:16 INFO - PID 9560 | 12:09:16 INFO - PID 9560 | [#4] prototype.html Cycles:180 Average:4624.24 Median:5167.64 stddev:1286.51 (24.9%) stddev-sans-first:1249.82 12:09:16 INFO - PID 9560 | Values: 367.8 388.6 396.9 397.5 402.1 5305.2 5327.3 5339.3 5357.0 5371.5 5244.5 5253.9 5254.9 5256.6 5267.4 4144.5 4175.6 4211.6 4221.8 4238.8 4216.9 4220.2 4237.0 4240.5 4241.2 4190.2 4193.0 4199.8 4203.4 4216.6 4058.3 4175.2 4217.4 4219.5 4222.2 3775.6 3780.6 3785.9 3794.9 3804.0 5120.9 5122.2 5133.7 5141.0 5142.2 4694.7 4842.3 4852.1 4857.1 4864.5 5508.2 5514.5 5536.2 5537.8 5542.2 4157.1 4160.2 4182.2 4186.1 4197.7 5345.3 5596.6 5741.3 5833.8 5842.7 4144.1 4246.1 4303.4 4324.7 4337.2 4378.3 4391.0 4397.7 4399.6 4400.3 4857.4 4864.0 4866.0 4871.7 4886.4 5434.6 5494.0 5499.5 5565.7 5567.6 1505.9 1525.2 1526.4 1526.7 1528.5 1052.9 1087.5 1096.3 1103.0 1112.4 4710.5 4712.3 4716.9 4721.7 4722.6 5647.2 5659.7 5662.4 5665.8 5680.8 4560.0 4681.3 4718.4 4721.6 4722.6 2954.9 2963.1 2963.9 2987.6 2995.0 5260.6 5287.4 5300.5 5300.9 5317.8 5525.4 5679.7 5765.8 5816.4 5826.8 5167.7 5178.4 5306.3 5333.2 5354.7 5624.6 5650.5 5667.7 5675.2 5679.3 5376.5 5598.1 5612.0 5622.0 5632.4 5338.1 5342.8 5346.5 5354.8 5377.8 4016.1 4030.3 4032.5 4035.4 4037.3 5526.3 5701.3 5724.0 5726.9 5733.6 5461.9 5489.6 5506.4 5522.9 5522.9 5356.5 5488.6 5496.4 5508.5 5523.3 5393.9 5408.8 5411.8 5441.4 5445.5 5523.9 5540.5 5548.3 5564.8 5566.2 5167.5 5349.0 5392.3 5397.8 5420.7 12:09:16 INFO - PID 9560 | 12:09:16 INFO - PID 9560 | [#5] yui.html Cycles:180 Average:13278.43 Median:22209.88 stddev:15738.75 (70.9%) stddev-sans-first:15754.37 12:09:16 INFO - PID 9560 | Values: 659.4 664.8 674.6 682.9 685.7 10769.5 11093.6 11113.1 11114.3 11146.1 11853.4 11920.8 12049.6 12240.2 12277.3 866.4 878.8 910.1 913.6 914.5 927.8 946.1 946.7 946.9 947.3 963.3 979.9 980.1 981.0 981.4 957.2 975.0 975.1 975.7 976.7 711.4 711.7 711.9 712.0 712.0 13072.5 13337.7 13399.7 13406.3 13494.9 12415.6 13007.7 13630.3 13696.3 13821.3 9547.5 9724.3 9930.9 10062.5 10393.0 2571.4 2593.4 2602.1 2652.2 2671.6 56940.4 60146.0 60266.1 60756.0 61391.4 10609.7 10612.9 10727.6 10736.5 10861.2 20008.9 20022.8 20194.6 20254.5 20270.6 5874.1 5909.4 5948.2 5972.9 6135.2 3075.8 3170.0 3205.2 3228.3 3249.8 3313.5 3388.9 3397.2 3441.7 3443.8 666.0 669.9 685.9 685.9 689.9 504.6 524.5 530.7 548.0 566.0 8022.3 8139.6 8259.4 8448.8 8524.2 499.7 499.8 517.9 542.8 543.1 3757.2 3785.3 3826.9 3866.2 4041.4 57954.8 58581.4 59252.8 59811.1 59852.0 47112.8 50498.0 51111.2 51194.0 52208.0 40378.4 40724.6 41386.8 41890.8 42707.6 9014.0 9794.7 9870.2 9886.3 9887.1 23813.0 23865.4 24405.6 24549.0 24948.3 29104.6 29630.7 29905.4 30538.0 30921.0 11163.6 11175.2 11223.0 11444.2 11530.5 12858.9 12870.6 13010.5 13204.3 13789.9 11669.0 11703.8 11707.8 12051.1 12072.4 11161.6 11366.9 11611.8 11616.3 12122.4 11036.8 11093.7 11185.4 11307.7 11339.1 8918.0 9022.1 9043.8 9199.0 9343.4 9962.9 10265.2 10272.2 10292.8 10306.4 12:09:16 INFO - PID 9560 | -------- Summary: end -------- 12:09:16 INFO - PID 9560 | 12:09:17 INFO - TEST-INFO | 9560: exit 0 12:09:17 INFO - TEST-OK | dromaeo_css | took 1122783ms 12:09:17 INFO - TEST-START | kraken 12:09:17 INFO - operating with platform_type : linux_ 12:09:17 INFO - Initialising browser for kraken test... 12:09:17 INFO - TEST-INFO | started process 9880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8EJ0P4/profile http://localhost:42509/getInfo.html) 12:09:21 INFO - PID 9880 | __metrics Screen width/height:1600/1200 12:09:21 INFO - PID 9880 | colorDepth:24 12:09:21 INFO - PID 9880 | Browser inner width/height: 1024/697 12:09:21 INFO - PID 9880 | __metrics 12:09:22 ERROR - PID 9880 | 1490814562175 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 12:09:22 INFO - PID 9880 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:09:22 INFO - PID 9880 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:09:23 INFO - TEST-INFO | 9880: exit 0 12:09:23 INFO - Browser initialized. 12:09:23 INFO - Running cycle 1/1 for kraken test... 12:09:23 INFO - TEST-INFO | started process 9976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8EJ0P4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:35 INFO - PID 9976 | RSS: Main: 149094400 12:09:35 INFO - PID 9976 | 12:09:38 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42509/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:39 INFO - PID 9976 | RSS: Main: 204640256 12:09:39 INFO - PID 9976 | 12:09:41 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42509/tests/kraken/driver.html?testName=audio-dft) 12:09:42 INFO - PID 9976 | RSS: Main: 183812096 12:09:42 INFO - PID 9976 | 12:09:45 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42509/tests/kraken/driver.html?testName=audio-fft) 12:09:46 INFO - PID 9976 | RSS: Main: 266805248 12:09:46 INFO - PID 9976 | 12:09:48 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42509/tests/kraken/driver.html?testName=audio-oscillator) 12:09:49 INFO - PID 9976 | RSS: Main: 177664000 12:09:49 INFO - PID 9976 | 12:09:51 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:51 INFO - PID 9976 | RSS: Main: 181284864 12:09:51 INFO - PID 9976 | 12:09:55 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42509/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:55 INFO - PID 9976 | RSS: Main: 220086272 12:09:55 INFO - PID 9976 | 12:09:59 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42509/tests/kraken/driver.html?testName=imaging-desaturate) 12:10:00 INFO - PID 9976 | RSS: Main: 213958656 12:10:00 INFO - PID 9976 | 12:10:03 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42509/tests/kraken/driver.html?testName=json-parse-financial) 12:10:03 INFO - PID 9976 | RSS: Main: 216858624 12:10:03 INFO - PID 9976 | 12:10:05 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:10:06 INFO - PID 9976 | RSS: Main: 180895744 12:10:06 INFO - PID 9976 | 12:10:07 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42509/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:10:08 INFO - PID 9976 | RSS: Main: 187863040 12:10:08 INFO - PID 9976 | 12:10:10 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:10:11 INFO - PID 9976 | RSS: Main: 196472832 12:10:11 INFO - PID 9976 | 12:10:14 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:10:15 INFO - PID 9976 | RSS: Main: 206360576 12:10:15 INFO - PID 9976 | 12:10:18 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:10:18 INFO - PID 9976 | RSS: Main: 202690560 12:10:18 INFO - PID 9976 | 12:10:20 INFO - PID 9976 | Cycle 1(1): loaded http://localhost:42509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42509/tests/kraken/driver.html?testName=ai-astar) 12:10:21 INFO - PID 9976 | RSS: Main: 272097280 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | __start_tp_report 12:10:21 INFO - PID 9976 | _x_x_mozilla_page_load 12:10:21 INFO - PID 9976 | _x_x_mozilla_page_load_details 12:10:21 INFO - PID 9976 | |i|pagename|runs| 12:10:21 INFO - PID 9976 | |0;ai-astar;109;113;111;114;114;111;113;114;114;112 12:10:21 INFO - PID 9976 | |1;audio-beat-detection;156;131;127;170;128;127;124;125;147;126 12:10:21 INFO - PID 9976 | |2;audio-dft;165;165;165;165;166;165;164;166;164;170 12:10:21 INFO - PID 9976 | |3;audio-fft;75;77;78;105;77;77;76;78;92;76 12:10:21 INFO - PID 9976 | |4;audio-oscillator;86;85;109;86;85;86;100;86;88;107 12:10:21 INFO - PID 9976 | |5;imaging-gaussian-blur;113;113;114;114;114;114;114;114;114;114 12:10:21 INFO - PID 9976 | |6;imaging-darkroom;154;150;150;149;149;150;150;150;150;151 12:10:21 INFO - PID 9976 | |7;imaging-desaturate;95;95;94;94;95;94;94;95;94;96 12:10:21 INFO - PID 9976 | |8;json-parse-financial;66;66;67;67;67;67;68;67;68;67 12:10:21 INFO - PID 9976 | |9;json-stringify-tinderbox;56;56;57;56;56;57;57;55;56;56 12:10:21 INFO - PID 9976 | |10;stanford-crypto-aes;84;84;84;85;87;84;84;85;84;86 12:10:21 INFO - PID 9976 | |11;stanford-crypto-ccm;151;153;144;140;140;140;140;133;192;147 12:10:21 INFO - PID 9976 | |12;stanford-crypto-pbkdf2;192;190;194;196;195;198;198;196;197;203 12:10:21 INFO - PID 9976 | |13;stanford-crypto-sha256-iterative;72;73;72;73;72;75;71;69;69;70 12:10:21 INFO - PID 9976 | __end_tp_report 12:10:21 INFO - PID 9976 | __start_cc_report 12:10:21 INFO - PID 9976 | _x_x_mozilla_cycle_collect,2031 12:10:21 INFO - PID 9976 | __end_cc_report 12:10:21 INFO - PID 9976 | __startTimestamp1490814621034__endTimestamp 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | ------- Summary: start ------- 12:10:21 INFO - PID 9976 | Number of tests: 14 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:1.72 (1.5%) stddev-sans-first:1.27 12:10:21 INFO - PID 9976 | Values: 109.0 113.0 111.0 114.0 114.0 111.0 113.0 114.0 114.0 112.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:129.50 stddev:15.96 (12.3%) stddev-sans-first:15.22 12:10:21 INFO - PID 9976 | Values: 156.0 131.0 127.0 170.0 128.0 127.0 124.0 125.0 147.0 126.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:1.72 (1.0%) stddev-sans-first:1.81 12:10:21 INFO - PID 9976 | Values: 165.0 165.0 165.0 165.0 166.0 165.0 164.0 166.0 164.0 170.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#3] audio-fft Cycles:10 Average:81.10 Median:77.00 stddev:9.71 (12.6%) stddev-sans-first:10.05 12:10:21 INFO - PID 9976 | Values: 75.0 77.0 78.0 105.0 77.0 77.0 76.0 78.0 92.0 76.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:86.00 stddev:9.64 (11.2%) stddev-sans-first:9.99 12:10:21 INFO - PID 9976 | Values: 86.0 85.0 109.0 86.0 85.0 86.0 100.0 86.0 88.0 107.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 12:10:21 INFO - PID 9976 | Values: 113.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:1.42 (0.9%) stddev-sans-first:0.60 12:10:21 INFO - PID 9976 | Values: 154.0 150.0 150.0 149.0 149.0 150.0 150.0 150.0 150.0 151.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 12:10:21 INFO - PID 9976 | Values: 95.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 96.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 12:10:21 INFO - PID 9976 | Values: 66.0 66.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 67.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 12:10:21 INFO - PID 9976 | Values: 56.0 56.0 57.0 56.0 56.0 57.0 57.0 55.0 56.0 56.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:1.06 (1.3%) stddev-sans-first:1.09 12:10:21 INFO - PID 9976 | Values: 84.0 84.0 84.0 85.0 87.0 84.0 84.0 85.0 84.0 86.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:145.50 stddev:16.56 (11.4%) stddev-sans-first:17.53 12:10:21 INFO - PID 9976 | Values: 151.0 153.0 144.0 140.0 140.0 140.0 140.0 133.0 192.0 147.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.90 Median:196.50 stddev:3.57 (1.8%) stddev-sans-first:3.50 12:10:21 INFO - PID 9976 | Values: 192.0 190.0 194.0 196.0 195.0 198.0 198.0 196.0 197.0 203.0 12:10:21 INFO - PID 9976 | 12:10:21 INFO - PID 9976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.90 (2.6%) stddev-sans-first:2.01 12:10:21 INFO - PID 9976 | Values: 72.0 73.0 72.0 73.0 72.0 75.0 71.0 69.0 69.0 70.0 12:10:21 INFO - PID 9976 | -------- Summary: end -------- 12:10:21 INFO - PID 9976 | 12:10:22 INFO - TEST-INFO | 9976: exit 0 12:10:22 INFO - TEST-OK | kraken | took 64965ms 12:10:22 INFO - SUITE-END | took 1187s 12:10:22 INFO - Completed test suite (00:19:48) 12:10:22 INFO - javascript benchmark 12:10:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6528.915614755583, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.227953893371, 2697.0964726816514, 2728.890844366225, 2734.043084920278, 2737.603047558104, 5136.563392111666, 5235.947640523594, 5308.780059119599, 5312.150055991042, 5378.489043540867, 5286.3392075990505, 5319.0, 5330.546903513206, 5364.088105022146, 5394.757235924383, 4557.977210113945, 4821.7830197641015, 4937.950620493785, 4975.776090075955, 4979.526944940225, 4892.584130348907, 4921.581665558432, 4922.55696987271, 4924.28597853311, 4936.605071594282, 4689.413823272091, 4742.478327383985, 4749.335093086971, 4812.975935120337, 4851.199552073904, 4809.182438985381, 4824.228123500223, 4856.757162141878, 4901.5588597026435, 4903.338049363326, 4786.377770889797, 4786.449558300805, 4788.329633851264, 4803.3995750531185, 4820.349252850855, 5110.207917772751, 5164.948350516522, 5290.795600911508, 5297.12597421425, 5341.252224688546, 5630.577706672016, 5644.717764111819, 5646.20953066571, 5646.350669672999, 5650.0, 5666.688332141731, 5675.3757086720425, 5689.886202275931, 5733.340665823442, 5742.167385729088, 5323.893522129536, 5328.467153284718, 5329.920051199235, 5330.253764472977, 5332.573394128461, 5703.8859222816145, 5761.107028410603, 5864.120381942743, 5880.441358070976, 5887.440693134231, 5498.340199176125, 5523.917141242885, 5607.383187849333, 5660.8867822643315, 5680.034394153004, 5768.798092066758, 5768.855778605568, 5769.913451298234, 5774.942250577525, 5807.157962095473, 5684.687342196219, 5727.083666613322, 5733.971330143406, 5741.167530708024, 5741.425857414309, 5458.344998600114, 5532.529734972572, 5534.418886016991, 5535.280413546294, 5715.514181294637, 4759.738214398172, 4810.350602668665, 4824.372831531879, 4824.565789079, 4827.686200396963, 4066.6337586445957, 4083.6324730773777, 4097.692673049533, 4111.876643700693, 4129.132882094734, 4762.285657151455, 4769.833055843098, 4770.198451402302, 4775.2359622460235, 4817.012512434942, 5516.365617953907, 5586.832395028156, 5592.832215033555, 5706.115552089433, 5753.88492230153, 4731.976340118277, 4762.499937506581, 4762.809487620526, 4791.736454495036, 4805.27920811881, 5071.0872043032605, 5076.13705670037, 5090.160123579568, 5105.33630628016, 5153.587712982952, 5140.151874940593, 5391.838244852583, 5403.756830942539, 5406.459354064562, 5415.83752487426, 5521.089020311603, 5569.969555632221, 5576.191452239484, 5710.2862142232225, 5790.363060063305, 5377.435369286325, 5377.516023557899, 5393.083175860192, 5405.891882162414, 5435.972820135874, 5644.096944488862, 5690.203371527907, 5692.402297758676, 5692.43075692444, 5693.231413759255, 5544.63959842609, 5563.304586926634, 5628.915566266591, 5648.124540696199, 5752.482276595127, 5582.86042848932, 5607.411221821813, 5608.943910560843, 5617.943820561905, 5618.859528511656, 5502.0371434997915, 5564.137558678412, 5604.159376093618, 5604.299462567179, 5607.214989901336, 5411.78352865881, 5421.701806400686, 5430.913817236489, 5465.371482279589, 5465.699386533779, 5418.647787893774, 5496.532794712494, 5605.579581531483, 5606.523445507178, 5650.745716442852, 5307.044731948286, 5381.596380271573, 5454.8909021818545, 5461.371942226695, 5469.3983661797965], "value": 5180.201419010899, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.5698226330252, 650.6096342194683, 662.4435474201671, 1075.397777244743, 1089.0470838016736, 26934.865325673392, 33118.83440582797, 33824.83087584559, 33855.322893542114, 33866.322673546514, 35532.11169720758, 36013.0, 36026.2794744105, 36030.27939441216, 36107.27785444296, 5679.858003549903, 7430.4427167962485, 7616.086069671647, 7619.047619047591, 7624.313811756969, 5696.2594862668, 7247.0, 7466.626668666572, 7481.962590187041, 7484.3638290745075, 7532.39740820733, 7590.58251796151, 7592.696292148307, 7592.772216833504, 7596.354309883666, 7498.6625601848045, 7561.508501947355, 7574.394048476109, 7581.090269167735, 7582.241775822401, 7306.890396644055, 7382.18795932447, 7392.6303684816085, 7399.926000739977, 7400.740974065936, 33256.33487330264, 33478.83260583682, 33522.329553408796, 33563.16092097693, 33591.160220994425, 2607.7131515533274, 2631.723669014745, 2638.4327369615626, 2643.458091091322, 2689.2201261634104, 22066.558668826532, 22097.447563810874, 22217.333479995625, 22305.44236394087, 22436.32691019272, 2538.0482319130324, 2552.8978840846344, 2554.0805310088354, 2561.0, 2564.192279431973, 136897.0, 137520.0, 138003.0, 138305.308473458, 138405.0, 39745.40381894274, 39847.80076099601, 39848.62422012464, 39858.60141398549, 39864.80405587837, 42403.363949540784, 42413.15173696509, 42425.36361954573, 42518.57481425208, 42523.787381063514, 10997.175211859143, 11237.494312755782, 11249.775004500028, 11249.918765028333, 11262.0, 8153.429259951747, 8305.543195124326, 8695.043545210021, 8703.738887833375, 8712.085231050774, 12581.748365032649, 12722.936385318015, 12737.808932866015, 12857.614271571867, 12951.0, 5296.437550922487, 5318.361796584357, 5361.383440904346, 5490.176473529003, 5536.557075434036, 855.8930133733284, 887.5650931043871, 895.4985208283382, 896.3098414221014, 918.6830543462495, 20144.194232230548, 20710.68933965992, 20820.167193312096, 20980.370588882357, 21142.365729028155, 939.9671011514564, 952.3428834104445, 952.5618215620754, 963.5712108111823, 974.9317547771587, 10403.219758518142, 10751.892481075245, 10883.401412922365, 10978.451077446096, 10980.505877235544, 234125.0, 234287.0, 235539.0, 235715.0, 235951.0, 41006.1798764029, 41603.58396416058, 41689.37465938013, 41727.79136104361, 41782.58217417787, 1175.5767923547517, 1199.622119032502, 1211.0977321895245, 1211.4306276050243, 1223.0399136677665, 18856.811431886053, 19203.679172186145, 20230.898845506268, 20273.59452810965, 20761.896190519554, 29564.0, 29581.556276655436, 29586.260343491584, 29594.704052959194, 29602.259943500725, 213054.0, 213113.0, 213368.0, 213740.0, 213870.0, 22787.430314242276, 23376.298711038697, 27854.16437506878, 28099.578506322014, 28134.71865281321, 31156.0, 31341.68658313479, 32243.516347255278, 32261.677383226805, 32369.33536631033, 23857.40356491032, 24400.26799196027, 24518.75481245236, 25034.874825625757, 25167.622485663094, 24219.75780242175, 24379.634305485786, 24760.380990475383, 24785.1325203617, 25035.248942531754, 26385.60421593716, 26464.470710586065, 26480.470390591694, 26648.733512664625, 26761.06336278221, 23929.401764956016, 24506.387340316636, 24880.50238995246, 24915.0, 24975.375615609755, 19941.900290498455, 20314.187432502535, 20433.386998390073, 20510.282140125026, 20575.897120514303], "value": 14189.645390798527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.24809853672184, 406.81286608160246, 426.14770459081825, 429.6670080687467, 437.70236239357223, 17117.486475405727, 17858.64282714345, 18524.90737546314, 18527.72208416873, 18530.07349632518, 18360.26558937641, 18596.07019649019, 18822.24711011561, 19296.614067718638, 19421.12604932778, 5701.57238207134, 5712.086066229404, 5833.562482813784, 5866.823995280149, 5868.501177399926, 5741.827745167651, 5852.063669812831, 5855.61938474, 5856.619319744224, 5859.209006784094, 5595.944040559583, 5671.319441667006, 5713.914291285634, 5718.857028574277, 5719.027765279891, 5648.519875810561, 5744.396838331978, 5782.9421705782825, 5798.826035218929, 5800.709964501758, 5160.380754309469, 5210.036143313461, 5216.356847592996, 5233.2935053768015, 5234.555062819665, 22373.776262237494, 22726.545469090524, 22859.428514287276, 22874.656880146813, 22986.0, 1542.8302886682457, 1551.43372668975, 1556.0585845563385, 1596.9201539922958, 1598.2168737318746, 13598.524051658145, 14444.205568693718, 14491.78262326066, 14533.927330363385, 15007.924960375238, 1685.6544408396248, 1687.940922067734, 1688.8057873344599, 1689.4762623586728, 1739.965200695979, 86222.5688871558, 87475.56262218712, 90170.5491472545, 90445.54777226137, 91317.54341228318, 10843.295185812896, 10994.450277486094, 11039.779204416027, 11232.943835280772, 11436.370999594936, 15388.0, 15438.15090170029, 15533.0, 15536.0, 15605.843941560666, 6957.965210173917, 7091.716331346792, 7197.964010179916, 7246.637668116573, 7353.669084891193, 6334.778282760173, 6441.613503189824, 6577.86844263112, 6589.439897608757, 6599.8020059398295, 7037.683304251321, 7082.752103676346, 7136.678849451787, 7169.562348801433, 7175.390091842252, 1930.758655168104, 1936.0, 2021.4036859126593, 2030.4111807575637, 2068.851787258086, 811.9512829230147, 822.2312138150849, 823.9340852731767, 838.1325328285195, 840.428508614136, 16659.3336266548, 16955.51660949594, 17260.223289951984, 17932.282708691506, 18011.18949647269, 844.991829088447, 855.3584811391456, 857.7005836158226, 860.4622111180512, 866.3199388480012, 9371.62513499466, 9587.568559414844, 9694.418334899929, 9721.951390243003, 9864.704058878246, 401789.0, 406778.9831525295, 411782.0, 413410.0, 413962.0, 87576.56211719027, 88002.0, 88602.0, 88844.11155888358, 89652.31043068718, 1042.0985847242082, 1078.7411021354976, 1092.1699508373692, 1098.4123493930708, 1099.279971618575, 17317.653646926738, 17391.913040434716, 18062.277508900024, 18129.45611631653, 18509.35217267443, 42970.57029429666, 43289.783551082044, 43397.78301108474, 44153.33769993517, 44412.77793611011, 55871.72064139653, 56247.71876140593, 56545.43454565402, 57242.7137864308, 58004.70997644985, 8135.430519863553, 8182.4681395709085, 8223.17768223173, 8274.967702976286, 8278.586070696321, 13065.934670326587, 13389.263590502616, 13456.730865382833, 13463.798043029557, 13499.190048597116, 10040.246981476272, 10070.647527336509, 10073.143782778547, 10592.364458132537, 11520.711982200512, 9243.537823108953, 9316.95341523288, 9349.719508414759, 9534.904650953402, 9642.469664168539, 10681.0, 10723.463826808784, 11092.833607495733, 11336.659900203007, 11528.654140375802, 8348.540830254151, 8368.121347258693, 8552.144785521397, 8633.223009929137, 8707.651693932425, 9963.800723985334, 10008.899911000797, 10191.490425478549, 10464.0, 11050.889491105308], "value": 8918.402774253587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1115.782422427627, 1260.6470188347264, 1294.857565667777, 1312.684955610653, 1315.0860152194225, 8357.707480238192, 9632.518374081294, 9865.112139907407, 9927.75180620485, 9940.602375904955, 9703.029697030312, 9789.559469823856, 9790.608375664982, 9800.215982721384, 9806.803863922718, 1859.4421673497964, 2168.27362833451, 2200.0759680934048, 2202.41635966469, 2202.4603972026875, 1937.951551211224, 2147.5060736030723, 2214.4906671465574, 2215.9889200553976, 2221.1115553778454, 2170.8697478151284, 2178.2049551913515, 2196.242296407737, 2197.6483762597986, 2198.3404978506464, 2153.956920861574, 2155.3641675705703, 2161.6973623692616, 2164.058634494, 2202.361315218585, 2166.0469393466824, 2172.5872084303933, 2183.912643494258, 2193.0, 2200.922967696139, 9716.61133554657, 9790.118889299925, 9800.215982721365, 9811.215102791759, 9813.803723925554, 4874.951250487486, 5037.244413337992, 5040.294358789773, 5043.747812609392, 5045.823396181116, 3133.8746450141966, 3289.9177520562175, 3292.0, 3304.7851889627095, 3322.9501557476656, 981.5190556627273, 1033.5813995331903, 1059.5602824827688, 1062.8671416072991, 1065.589747947046, 14465.0, 14489.492867749577, 14506.0, 14512.419503219964, 14514.491992780202, 4909.459959404463, 5026.547610715053, 5048.545630893237, 5086.593072554187, 5108.642395032312, 12133.69665758363, 12139.453724582238, 12163.452644631012, 12166.635000949986, 12174.086943479275, 5149.356330458692, 5194.065068287745, 5230.032443997797, 5262.578993680497, 5282.418933917266, 4480.686351955332, 4687.859364219079, 4737.95262047382, 4761.880952976203, 4768.332433459318, 3896.844126234919, 3980.7810570418906, 4008.8596899108393, 4029.7985100744845, 4137.710360274812, 1268.543324403214, 1278.5908509276942, 1285.479380850757, 1290.6450726050412, 1315.7894736842252, 646.3697894552868, 668.9364510371507, 671.3018460800713, 676.8443258050676, 677.1907570453261, 4905.828296009694, 5223.921641175385, 5766.163906233573, 5767.769289228468, 5839.386864379264, 528.2709860392633, 532.7283085626359, 532.9014132385521, 535.7830078818085, 538.4588488568963, 3222.6455089940087, 3241.157299102203, 3278.1149089745636, 3313.237955270253, 3391.6947474727394, 12289.262644241375, 12693.936530317289, 12833.807492887614, 12845.550405735754, 12853.421596028202, 12765.744685106245, 12775.488980440678, 12778.424970876147, 12779.616611501484, 12812.974962003018, 8821.250193733476, 9200.35597508168, 9300.581473833558, 9312.487813170204, 9364.297677674202, 5451.373092094302, 5469.179623056573, 5549.472800083986, 5618.550515958632, 5674.602777805514, 10982.231243813176, 11126.554937802397, 11179.441027948407, 11242.325460472397, 11316.717082073013, 10228.64199753005, 11518.769624607294, 11575.363355015555, 11626.70933226676, 11692.181547291608, 6884.690188941409, 8118.675252989814, 8121.066077400938, 8144.389170812331, 8146.511209327459, 8918.509481978293, 9094.772630684285, 9234.769130771516, 9243.445393276425, 9281.907180928105, 7560.58416787082, 7685.38516918634, 7721.112072111779, 7770.92229077702, 7874.606269686607, 7520.586367749826, 7559.470837041355, 7585.165631780389, 7715.22847715224, 7899.0, 6335.429811317003, 6427.421532062137, 6428.774992875227, 6428.939225027818, 6429.6142231466265, 4798.206278026906, 4915.361003069578, 4941.876453088702, 4948.38145231846, 4983.601311894967, 4706.294055891643, 4843.055604157155, 4883.291922671264, 4929.605631549539, 5000.0], "value": 4543.5200712616615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.77014366021234, 388.5628667748783, 396.8551478710271, 397.53289884385856, 402.1013035864842, 5305.151175811871, 5327.2808170896915, 5339.305890234274, 5356.9732151339285, 5371.543418809396, 5244.475552444754, 5253.921191182126, 5254.921176182351, 5256.605754568413, 5267.39424966129, 4144.52337981133, 4175.645070169024, 4211.599898009684, 4221.831126754926, 4238.8092535835885, 4216.894577635553, 4220.240356735786, 4237.0, 4240.512341080769, 4241.215375155591, 4190.161967606491, 4193.0, 4199.811008504625, 4203.4115223868685, 4216.578342165774, 4058.3157989434644, 4175.185838761443, 4217.40956266123, 4219.472565929259, 4222.239996800575, 3775.5846856845724, 3780.640839120279, 3785.9053523661855, 3794.9430758538642, 3803.9619603804163, 5120.897582048376, 5122.154844450662, 5133.743312834381, 5140.974295128501, 5142.177251639757, 4694.671373003891, 4842.322074909515, 4852.126617208901, 4857.149998750205, 4864.513548645143, 5508.20131080995, 5514.503694667459, 5536.197251398525, 5537.833864984057, 5542.196381524696, 4157.10622216222, 4160.188763191179, 4182.205380977604, 4186.0581369192, 4197.727147735418, 5345.305110335631, 5596.608237423382, 5741.25363702716, 5833.82498525045, 5842.707864606795, 4144.109016561454, 4246.065865509583, 4303.440552728125, 4324.654027677778, 4337.175936572105, 4378.277584198635, 4391.033972526039, 4397.73613583186, 4399.5820397062225, 4400.339949007611, 4857.368542089576, 4864.0028794097125, 4866.0, 4871.683340582922, 4886.364772579613, 5434.592405569598, 5493.972530137324, 5499.477549632778, 5565.7217139143695, 5567.638103523258, 1505.8720008799376, 1525.1764047414495, 1526.4275896538797, 1526.7328217561883, 1528.533797191845, 1052.8789189243334, 1087.483445363462, 1096.3202814255212, 1102.9944850275697, 1112.3659514076899, 4710.505396933341, 4712.31671407644, 4716.9056618867435, 4721.693089949143, 4722.598579120745, 5647.209390685307, 5659.660420374708, 5662.365945883872, 5665.830025099253, 5680.7727690892725, 4560.0, 4681.344611754357, 4718.381298379432, 4721.5986641135205, 4722.5513576210205, 2954.896578619738, 2963.1110666799873, 2963.940721185564, 2987.5668028135797, 2995.0, 5260.63223561869, 5287.41838397776, 5300.469953004668, 5300.893982120336, 5317.803494213848, 5525.364583072998, 5679.716014199274, 5765.798197063083, 5816.418358164235, 5826.82519524415, 5167.741612919339, 5178.430372659004, 5306.257124002643, 5333.200019996954, 5354.705491198021, 5624.634398764068, 5650.547956163415, 5667.744951477111, 5675.177099320493, 5679.290088738908, 5376.516113549643, 5598.076317407582, 5611.969536450271, 5621.971890140523, 5632.380438151718, 5338.065838478328, 5342.813001544927, 5346.465353464622, 5354.812581559627, 5377.784888604412, 4016.0562267867613, 4030.314846476165, 4032.495938007749, 4035.4148648445225, 4037.2732908075654, 5526.336839579276, 5701.258836351413, 5724.0, 5726.885462290814, 5733.598648094593, 5461.9453805461435, 5489.643173193889, 5506.375619192268, 5522.861928451821, 5522.944770552243, 5356.491133342326, 5488.643238189505, 5496.422875598005, 5508.476694713996, 5523.254360661259, 5393.919091213556, 5408.8377348679605, 5411.78352865881, 5441.401445840876, 5445.455454454681, 5523.922835047128, 5540.501354878081, 5548.280033189724, 5564.805231816867, 5566.165075238747, 5167.534921857051, 5348.956953394051, 5392.272043274108, 5397.8380648580605, 5420.728963551728], "value": 4241.640028266975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.3999460490954, 664.8271449423148, 674.5952428542874, 682.9453643708504, 685.674304705265, 10769.461526923662, 11093.611723589665, 11113.11095112391, 11114.277571957817, 11146.108311335094, 11853.407329633505, 11920.821187682192, 12049.578264760736, 12240.204386714857, 12277.263364198154, 866.3891956170916, 878.8154487557605, 910.1399177777004, 913.6391125505454, 914.5381582300929, 927.8144371125768, 946.129560804062, 946.7017889364828, 946.857971304303, 947.327397547742, 963.2534785541227, 979.8677178580872, 980.1423754215061, 980.9558569864338, 981.3523074770653, 957.2198658093666, 975.0, 975.0980343182528, 975.7170420578024, 976.6581696406272, 711.4415184080524, 711.7473296979549, 711.900333953247, 711.9750808721722, 711.9928800711979, 13072.477100915952, 13337.666558336023, 13399.665008374772, 13406.329683515884, 13494.93252533731, 12415.565455209115, 13007.739845203043, 13630.250336231504, 13696.315184240748, 13821.272340957381, 9547.52262386878, 9724.319297649168, 9930.851037234448, 10062.547185376676, 10392.960703929622, 2571.434284457416, 2593.351662084479, 2602.0892687559394, 2652.244110428538, 2671.6259723638514, 56940.43059569434, 60146.0, 60266.09600855947, 60756.0, 61391.38608613901, 10609.734756631146, 10612.946935265429, 10727.570897164025, 10736.516856741466, 10861.1854110942, 20008.89995550042, 20022.799772002385, 20194.59610807805, 20254.49363765888, 20270.594588108157, 5874.089516125007, 5909.409059094056, 5948.226730525091, 5972.850678733066, 6135.171751813537, 3075.815451072943, 3169.952450713241, 3205.166656669283, 3228.2736384313343, 3249.8050116993054, 3313.519539666735, 3388.8644454221553, 3397.1846756778195, 3441.741869359808, 3443.810590417551, 665.9766908158288, 669.8727241824038, 685.8971154326891, 685.917689877218, 689.9379055884995, 504.64422582079544, 524.5122036506086, 530.6895466152267, 547.9671219726829, 565.9801906933237, 8022.318102961313, 8139.593020349077, 8259.380546458919, 8448.788780280542, 8524.232819046316, 499.7306840624845, 499.7501249375312, 517.9171332586768, 542.7557599080351, 543.0767694918654, 3757.1734218471893, 3785.337565925952, 3826.885193444201, 3866.168773713665, 4041.373587094005, 57954.8409031817, 58581.4141858576, 59252.81494370088, 59811.10283345753, 59852.0, 47112.7644361776, 50498.0, 51111.23333150006, 51194.0, 52208.0, 40378.39432408458, 40724.59275407208, 41386.79306603448, 41890.79054604707, 42707.57292427098, 9014.0, 9794.706158815246, 9870.161036311707, 9886.30795844284, 9887.110160085627, 23813.0, 23865.40336491532, 24405.633915490926, 24549.0, 24948.251552453454, 29104.56343154812, 29630.703692962794, 29905.401891961603, 30538.0, 30921.0, 11163.609273675707, 11175.202586723319, 11223.0, 11444.198906076828, 11530.538778449103, 12858.925096062902, 12870.613881583567, 13010.47958081704, 13204.27376494302, 13789.862101378858, 11669.011433213824, 11703.76592468163, 11707.765844682888, 12051.096167787276, 12072.396380181131, 11161.609343672932, 11366.943165284121, 11611.767764644828, 11616.303021818718, 12122.393880306126, 11036.834447483454, 11093.667189984313, 11185.440727963733, 11307.717307067389, 11339.149563782914, 8918.0, 9022.14289642483, 9043.819123617359, 9198.954005230198, 9343.392679475812, 9962.900370996198, 10265.178785697275, 10272.22958278147, 10292.794144116926, 10306.381617102998], "value": 6130.30335003072, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 111.0, 114.0, 114.0, 111.0, 113.0, 114.0, 114.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 131.0, 127.0, 170.0, 128.0, 127.0, 124.0, 125.0, 147.0, 126.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 165.0, 166.0, 165.0, 164.0, 166.0, 164.0, 170.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 105.0, 77.0, 77.0, 76.0, 78.0, 92.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 109.0, 86.0, 85.0, 86.0, 100.0, 86.0, 88.0, 107.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 150.0, 149.0, 149.0, 150.0, 150.0, 150.0, 150.0, 151.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 96.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 56.0, 56.0, 57.0, 57.0, 55.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 87.0, 84.0, 84.0, 85.0, 84.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 144.0, 140.0, 140.0, 140.0, 140.0, 133.0, 192.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 190.0, 194.0, 196.0, 195.0, 198.0, 198.0, 196.0, 197.0, 203.0], "value": 195.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 73.0, 72.0, 75.0, 71.0, 69.0, 69.0, 70.0], "value": 71.6, "unit": "score"}]}]} 12:10:22 INFO - Return code: 0 12:10:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:10:22 ERROR - # TBPL SUCCESS # 12:10:22 INFO - Running post-action listener: _resource_record_post_action 12:10:22 INFO - [mozharness: 2017-03-29 19:10:22.851511Z] Finished run-tests step (success) 12:10:22 INFO - Running post-run listener: _resource_record_post_run 12:10:22 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 204800; Write bytes: 371781632; Read time: 228; Write time: 233876 12:10:22 INFO - TinderboxPrint: CPU usage
13.0% 12:10:22 INFO - TinderboxPrint: I/O read bytes / time
204,800 / 228 12:10:22 INFO - TinderboxPrint: I/O write bytes / time
371,781,632 / 233,876 12:10:22 INFO - TinderboxPrint: CPU idle
8,361.2 (87.0%) 12:10:22 INFO - TinderboxPrint: CPU user
1,201.5 (12.5%) 12:10:22 INFO - TinderboxPrint: Swap in / out
0 / 0 12:10:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113983488; Read time: 0; Write time: 97788 12:10:22 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 200704; Write bytes: 257798144; Read time: 216; Write time: 136088 12:10:23 INFO - Running post-run listener: _upload_blobber_files 12:10:23 INFO - Blob upload gear active. 12:10:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:10: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 12:10: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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:10: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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:10:23 INFO - (blobuploader) - INFO - Open directory for files ... 12:10:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:10:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:10:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:24 INFO - (blobuploader) - INFO - Done attempting. 12:10:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:10:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:10:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:25 INFO - (blobuploader) - INFO - Done attempting. 12:10:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:10:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:10:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:29 INFO - (blobuploader) - INFO - Done attempting. 12:10:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:10:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:10:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:30 INFO - (blobuploader) - INFO - Done attempting. 12:10:30 INFO - (blobuploader) - INFO - Iteration through files over. 12:10:30 INFO - Return code: 0 12:10:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:10:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:10:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9e6eedee7e3b02fc86cd44cf5c504fe4149dfbf60324e6aa09fe5f13f0988de672a1f7b7f7218098967b59f9a923a2e8328f6ff7de6354711c6552fe3d06a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bae5bf33fbef5457fbfef663fe85f96eb0898a49c874635c47580e9773cbdc787e8055789cb48bb3e4f3866034bb30a2a50ad4a0d30ed11d84293ee8f0a21655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e808186534a04261a818eb28523068ff323bb0bff84db0c98e7dbe555b882570189d7321734a08c537a8ed920e2083cd50b42e90d91da0ebe64d67dc90351674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d99bd43514159fb7962bf36f708064e2a588ed635ea19cad7af017a06e8e8da483d9351f889024ef2c5b81163f93f260b57e1d084ffa40ad8d3476b163ff0ffb"} 12:10:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:10:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:10:30 INFO - Contents: 12:10:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9e6eedee7e3b02fc86cd44cf5c504fe4149dfbf60324e6aa09fe5f13f0988de672a1f7b7f7218098967b59f9a923a2e8328f6ff7de6354711c6552fe3d06a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bae5bf33fbef5457fbfef663fe85f96eb0898a49c874635c47580e9773cbdc787e8055789cb48bb3e4f3866034bb30a2a50ad4a0d30ed11d84293ee8f0a21655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e808186534a04261a818eb28523068ff323bb0bff84db0c98e7dbe555b882570189d7321734a08c537a8ed920e2083cd50b42e90d91da0ebe64d67dc90351674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d99bd43514159fb7962bf36f708064e2a588ed635ea19cad7af017a06e8e8da483d9351f889024ef2c5b81163f93f260b57e1d084ffa40ad8d3476b163ff0ffb"} 12:10:30 INFO - Running post-run listener: copy_logs_to_upload_dir 12:10:30 INFO - Copying logs to upload dir... 12:10:30 INFO - mkdir: /builds/slave/test/build/upload/logs 12:10:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.274311 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-29 12:10:30.400558) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 12:10:30.403568) ========= 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=41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9e6eedee7e3b02fc86cd44cf5c504fe4149dfbf60324e6aa09fe5f13f0988de672a1f7b7f7218098967b59f9a923a2e8328f6ff7de6354711c6552fe3d06a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bae5bf33fbef5457fbfef663fe85f96eb0898a49c874635c47580e9773cbdc787e8055789cb48bb3e4f3866034bb30a2a50ad4a0d30ed11d84293ee8f0a21655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e808186534a04261a818eb28523068ff323bb0bff84db0c98e7dbe555b882570189d7321734a08c537a8ed920e2083cd50b42e90d91da0ebe64d67dc90351674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d99bd43514159fb7962bf36f708064e2a588ed635ea19cad7af017a06e8e8da483d9351f889024ef2c5b81163f93f260b57e1d084ffa40ad8d3476b163ff0ffb"} build_url:https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9e6eedee7e3b02fc86cd44cf5c504fe4149dfbf60324e6aa09fe5f13f0988de672a1f7b7f7218098967b59f9a923a2e8328f6ff7de6354711c6552fe3d06a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bae5bf33fbef5457fbfef663fe85f96eb0898a49c874635c47580e9773cbdc787e8055789cb48bb3e4f3866034bb30a2a50ad4a0d30ed11d84293ee8f0a21655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e808186534a04261a818eb28523068ff323bb0bff84db0c98e7dbe555b882570189d7321734a08c537a8ed920e2083cd50b42e90d91da0ebe64d67dc90351674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d99bd43514159fb7962bf36f708064e2a588ed635ea19cad7af017a06e8e8da483d9351f889024ef2c5b81163f93f260b57e1d084ffa40ad8d3476b163ff0ffb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 12:10:30.428477) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:10:30.428774) ========= 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=41bf3e9aed84707956354da8000001c5-1490813365.165660-136614894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:10:30.511215) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 12:10:30.511529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 12:10:30.511823) ========= ========= Total master_lag: 0.17 =========