builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1492507326.62 results: success (0) revision: 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:06.619531) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:06.619968) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:06.620248) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:06.634850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:06.635157) ========= 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=14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-18 02:22:06-- 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% 37.4M=0s 2017-04-18 02:22:06 (37.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126667 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:06.775458) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:06.775762) ========= 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=14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017506 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:06.825771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 02:22:06.826175) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 --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 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 --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=14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-18 02:22:06,991 truncating revision to first 12 chars 2017-04-18 02:22:06,991 Setting DEBUG logging. 2017-04-18 02:22:06,991 attempt 1/10 2017-04-18 02:22:06,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/92f94fc0993b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 02:22:08,813 unpacking tar archive at: mozilla-central-92f94fc0993b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.116027 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 02:22:08.956325) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:08.956669) ========= script_repo_revision: 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:08.957111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:08.957411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 02:22:08.968485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-18 02:22:08.969136) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:22:09 INFO - MultiFileLogger online at 20170418 02:22:09 in /builds/slave/test 02:22:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:22:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:22:09 INFO - {'append_to_log': False, 02:22:09 INFO - 'base_work_dir': '/builds/slave/test', 02:22:09 INFO - 'blob_upload_branch': 'Firefox', 02:22:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:22:09 INFO - 'branch': 'Firefox', 02:22:09 INFO - 'buildbot_json_path': 'buildprops.json', 02:22:09 INFO - 'config_files': ('talos/linux_config.py',), 02:22:09 INFO - 'default_actions': ('clobber', 02:22:09 INFO - 'read-buildbot-config', 02:22:09 INFO - 'download-and-extract', 02:22:09 INFO - 'populate-webroot', 02:22:09 INFO - 'create-virtualenv', 02:22:09 INFO - 'install', 02:22:09 INFO - 'run-tests'), 02:22:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:22:09 INFO - 'download_minidump_stackwalk': True, 02:22:09 INFO - 'download_symbols': 'ondemand', 02:22:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:22:09 INFO - 'tooltool.py': '/tools/tooltool.py', 02:22:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:22:09 INFO - '/tools/misc-python/virtualenv.py')}, 02:22:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:22:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:22:09 INFO - 'gecko_profile': False, 02:22:09 INFO - 'gecko_profile_interval': 0, 02:22:09 INFO - 'installer_path': 'installer.exe', 02:22:09 INFO - 'log_level': 'info', 02:22:09 INFO - 'log_name': 'talos', 02:22:09 INFO - 'log_to_console': True, 02:22:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:22:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:22:09 INFO - 'opt_config_files': (), 02:22:09 INFO - 'pip_index': False, 02:22:09 INFO - 'suite': 'dromaeojs', 02:22:09 INFO - 'system_bits': '32', 02:22:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:22:09 INFO - 'title': 'talos-linux64-ix-036', 02:22:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:22:09 INFO - 'use_talos_json': True, 02:22:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:22:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:22:09 INFO - 'work_dir': 'build'} 02:22:09 INFO - [mozharness: 2017-04-18 09:22:09.233927Z] Running clobber step. 02:22:09 INFO - Running pre-action listener: _resource_record_pre_action 02:22:09 INFO - Running main action method: clobber 02:22:09 INFO - rmtree: /builds/slave/test/build 02:22:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:22:10 INFO - Running post-action listener: _resource_record_post_action 02:22:10 INFO - [mozharness: 2017-04-18 09:22:10.694540Z] Finished clobber step (success) 02:22:10 INFO - [mozharness: 2017-04-18 09:22:10.694639Z] Running read-buildbot-config step. 02:22:10 INFO - Running pre-action listener: _resource_record_pre_action 02:22:10 INFO - Running main action method: read_buildbot_config 02:22:10 INFO - Using buildbot properties: 02:22:10 INFO - { 02:22:10 INFO - "project": "", 02:22:10 INFO - "product": "firefox", 02:22:10 INFO - "who": "cbook@mozilla.com", 02:22:10 INFO - "installer_path": "public/build/target.tar.bz2", 02:22:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 02:22:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:22:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 02:22:10 INFO - "stage_platform": "linux64-pgo", 02:22:10 INFO - "basedir": "/builds/slave/test", 02:22:10 INFO - "buildnumber": 132, 02:22:10 INFO - "platform": "ubuntu64_hw", 02:22:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:22:10 INFO - "slavebuilddir": "test", 02:22:10 INFO - "taskId": "GXnzBq5kRpu4vzzcVPxYHA", 02:22:10 INFO - "branch": "mozilla-central", 02:22:10 INFO - "script_repo_revision": "production", 02:22:10 INFO - "revision": "92f94fc0993bcba7ac34cae4c0e82b06012bcd91", 02:22:10 INFO - "slavename": "talos-linux64-ix-036", 02:22:10 INFO - "repo_path": "mozilla-central" 02:22:10 INFO - } 02:22:10 INFO - Finding installer, test and symbols from parent task. 02:22:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GXnzBq5kRpu4vzzcVPxYHA'}, attempt #1 02:22:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GXnzBq5kRpu4vzzcVPxYHA'}, attempt #1 02:22:11 INFO - Task dependencies: NNoH2L9PSmiGYcvMu4i_GQ 02:22:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ'}, attempt #1 02:22:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.tar.bz2 02:22:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/test_packages.json 02:22:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.crashreporter-symbols.zip 02:22:12 INFO - Running post-action listener: _resource_record_post_action 02:22:12 INFO - [mozharness: 2017-04-18 09:22:12.055851Z] Finished read-buildbot-config step (success) 02:22:12 INFO - [mozharness: 2017-04-18 09:22:12.056069Z] Running download-and-extract step. 02:22:12 INFO - Running pre-action listener: _resource_record_pre_action 02:22:12 INFO - Running main action method: download_and_extract 02:22:12 INFO - mkdir: /builds/slave/test/build/tests 02:22:12 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')]} 02:22:12 INFO - trying https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.test_packages.json 02:22:12 INFO - Downloading https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:22:12 INFO - Downloaded 986 bytes. 02:22:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:22:12 INFO - Using the following test package requirements: 02:22:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:22:12 INFO - u'common': [u'target.common.tests.zip'], 02:22:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:22:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:22:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:22:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:22:12 INFO - u'mozbase': [u'target.common.tests.zip'], 02:22:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:22:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:22:12 INFO - u'web-platform': [u'target.common.tests.zip', 02:22:12 INFO - u'target.web-platform.tests.zip'], 02:22:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:22:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:22:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.common.tests.zip 02:22:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:22:12 INFO - Fetch https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.common.tests.zip into memory 02:22:13 INFO - Expected file size: 60463703 02:22:13 INFO - Obtained file size: 60463703 02:22:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:22:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.common.tests.zip 02:22:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:22:23 INFO - Fetch https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.common.tests.zip into memory 02:22:24 INFO - Expected file size: 60463703 02:22:24 INFO - Obtained file size: 60463703 02:22:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.talos.tests.zip 02:22:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:22:35 INFO - Fetch https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.talos.tests.zip into memory 02:22:36 INFO - Expected file size: 14408802 02:22:36 INFO - Obtained file size: 14408802 02:22:36 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')]} 02:22:36 INFO - trying https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.tar.bz2 02:22:36 INFO - Downloading https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:22:38 INFO - Downloaded 63739377 bytes. 02:22:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.tar.bz2 02:22:38 INFO - mkdir: /builds/slave/test/properties 02:22:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:22:38 INFO - Writing to file /builds/slave/test/properties/build_url 02:22:38 INFO - Contents: 02:22:38 INFO - build_url:https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.tar.bz2 02:22:38 INFO - Running post-action listener: _resource_record_post_action 02:22:38 INFO - Running post-action listener: set_extra_try_arguments 02:22:38 INFO - [mozharness: 2017-04-18 09:22:38.004246Z] Finished download-and-extract step (success) 02:22:38 INFO - [mozharness: 2017-04-18 09:22:38.004343Z] Running populate-webroot step. 02:22:38 INFO - Running pre-action listener: _resource_record_pre_action 02:22:38 INFO - Running main action method: populate_webroot 02:22:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:22:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:22:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:22:38 INFO - '--tppagecycles', 02:22:38 INFO - '7'], 02:22:38 INFO - 'tests': ['tsvgm']}}, 02:22:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:22:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:22:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:22:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:22:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:22:38 INFO - 'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:22:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:22:38 INFO - 'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['damp', 'tps']}, 02:22:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:22:38 INFO - 'tests': ['damp', 'tps']}, 02:22:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['dromaeo_dom']}, 02:22:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:22:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:22:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:22:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['a11yr', 02:22:38 INFO - 'ts_paint', 02:22:38 INFO - 'tpaint', 02:22:38 INFO - 'sessionrestore', 02:22:38 INFO - 'sessionrestore_no_auto_restore', 02:22:38 INFO - 'tabpaint']}, 02:22:38 INFO - 'other-e10s': {'tests': ['a11yr', 02:22:38 INFO - 'ts_paint', 02:22:38 INFO - 'tpaint', 02:22:38 INFO - 'sessionrestore', 02:22:38 INFO - 'sessionrestore_no_auto_restore', 02:22:38 INFO - 'tabpaint']}, 02:22:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:22:38 INFO - 'ts_paint', 02:22:38 INFO - 'tpaint', 02:22:38 INFO - 'sessionrestore', 02:22:38 INFO - 'sessionrestore_no_auto_restore', 02:22:38 INFO - 'tabpaint']}, 02:22:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:22:38 INFO - 'ts_paint', 02:22:38 INFO - 'tpaint', 02:22:38 INFO - 'sessionrestore', 02:22:38 INFO - 'sessionrestore_no_auto_restore', 02:22:38 INFO - 'tabpaint']}, 02:22:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['a11yr', 02:22:38 INFO - 'ts_paint', 02:22:38 INFO - 'tpaint', 02:22:38 INFO - 'sessionrestore', 02:22:38 INFO - 'sessionrestore_no_auto_restore', 02:22:38 INFO - 'tabpaint']}, 02:22:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['a11yr', 02:22:38 INFO - 'ts_paint', 02:22:38 INFO - 'tpaint', 02:22:38 INFO - 'sessionrestore', 02:22:38 INFO - 'sessionrestore_no_auto_restore', 02:22:38 INFO - 'tabpaint']}, 02:22:38 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:22:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:22:38 INFO - 'bloom_basic_ref']}, 02:22:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['tsvgx', 02:22:38 INFO - 'tsvgr_opacity', 02:22:38 INFO - 'tart', 02:22:38 INFO - 'tscrollx', 02:22:38 INFO - 'cart', 02:22:38 INFO - 'tsvg_static']}, 02:22:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:22:38 INFO - 'tsvgr_opacity', 02:22:38 INFO - 'tart', 02:22:38 INFO - 'tscrollx', 02:22:38 INFO - 'cart', 02:22:38 INFO - 'tsvg_static']}, 02:22:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:22:38 INFO - 'talos_options': ['--disable-e10s'], 02:22:38 INFO - 'tests': ['tp5o']}, 02:22:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:22:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:22:38 INFO - 'talos_options': ['--disable-e10s', 02:22:38 INFO - '--xperf_path', 02:22:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:38 INFO - 'tests': ['tp5n']}, 02:22:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:22:38 INFO - 'talos_options': ['--xperf_path', 02:22:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:38 INFO - 'tests': ['tp5n']}}, 02:22:38 INFO - 'talos.zip': {'path': '', 02:22:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:22:38 INFO - Running post-action listener: _resource_record_post_action 02:22:38 INFO - [mozharness: 2017-04-18 09:22:38.020074Z] Finished populate-webroot step (success) 02:22:38 INFO - [mozharness: 2017-04-18 09:22:38.020162Z] Running create-virtualenv step. 02:22:38 INFO - Running pre-action listener: _resource_record_pre_action 02:22:38 INFO - Running main action method: create_virtualenv 02:22:38 INFO - Creating virtualenv /builds/slave/test/build/venv 02:22:38 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 02:22:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:22:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:22:38 INFO - Using real prefix '/usr' 02:22:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:22:38 INFO - Installing distribute.............................................................................................................................................................................................done. 02:22:40 INFO - Installing pip.................done. 02:22:40 INFO - Return code: 0 02:22:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:22:40 INFO - Reading from file tmpfile_stdout 02:22:40 INFO - Output received: 02:22:40 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) 02:22:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:40 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 0x20fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', '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 02:22:40 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 02:22:40 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 02:22:40 INFO - Using env: {'DISPLAY': ':0', 02:22:40 INFO - 'HOME': '/home/cltbld', 02:22:40 INFO - 'LANG': 'en_US.UTF-8', 02:22:40 INFO - 'LANGUAGE': 'en_US:en', 02:22:40 INFO - 'LOGNAME': 'cltbld', 02:22:40 INFO - 'MAIL': '/var/mail/cltbld', 02:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:40 INFO - 'MOZ_NO_REMOTE': '1', 02:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:40 INFO - 'NO_EM_RESTART': '1', 02:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:40 INFO - 'PWD': '/builds/slave/test', 02:22:40 INFO - 'SHELL': '/bin/bash', 02:22:40 INFO - 'SHLVL': '1', 02:22:40 INFO - 'TERM': 'linux', 02:22:40 INFO - 'TMOUT': '86400', 02:22:40 INFO - 'USER': 'cltbld', 02:22:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:40 INFO - '_': '/tools/buildbot/bin/python'} 02:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:41 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 02:22:41 INFO - Cleaning up... 02:22:41 INFO - Return code: 0 02:22:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:41 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 0x20fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', '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 02:22:41 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 02:22:41 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 02:22:41 INFO - Using env: {'DISPLAY': ':0', 02:22:41 INFO - 'HOME': '/home/cltbld', 02:22:41 INFO - 'LANG': 'en_US.UTF-8', 02:22:41 INFO - 'LANGUAGE': 'en_US:en', 02:22:41 INFO - 'LOGNAME': 'cltbld', 02:22:41 INFO - 'MAIL': '/var/mail/cltbld', 02:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:41 INFO - 'MOZ_NO_REMOTE': '1', 02:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:41 INFO - 'NO_EM_RESTART': '1', 02:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:41 INFO - 'PWD': '/builds/slave/test', 02:22:41 INFO - 'SHELL': '/bin/bash', 02:22:41 INFO - 'SHLVL': '1', 02:22:41 INFO - 'TERM': 'linux', 02:22:41 INFO - 'TMOUT': '86400', 02:22:41 INFO - 'USER': 'cltbld', 02:22:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:41 INFO - '_': '/tools/buildbot/bin/python'} 02:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:41 INFO - Downloading/unpacking psutil>=3.1.1 02:22:41 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 02:22:41 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 02:22:41 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 02:22:41 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 02:22:41 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 02:22:41 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 02:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:43 INFO - Installing collected packages: psutil 02:22:43 INFO - Running setup.py install for psutil 02:22:43 INFO - building 'psutil._psutil_linux' extension 02:22:43 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 02:22:43 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 02:22:43 INFO - building 'psutil._psutil_posix' extension 02:22:43 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 02:22:43 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 02:22:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:43 INFO - Successfully installed psutil 02:22:43 INFO - Cleaning up... 02:22:43 INFO - Return code: 0 02:22:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:22:43 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')]} 02:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:43 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')]} 02:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', '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 02:22:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:22:44 INFO - Using env: {'DISPLAY': ':0', 02:22:44 INFO - 'HOME': '/home/cltbld', 02:22:44 INFO - 'LANG': 'en_US.UTF-8', 02:22:44 INFO - 'LANGUAGE': 'en_US:en', 02:22:44 INFO - 'LOGNAME': 'cltbld', 02:22:44 INFO - 'MAIL': '/var/mail/cltbld', 02:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:44 INFO - 'MOZ_NO_REMOTE': '1', 02:22:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:44 INFO - 'NO_EM_RESTART': '1', 02:22:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:44 INFO - 'PWD': '/builds/slave/test', 02:22:44 INFO - 'SHELL': '/bin/bash', 02:22:44 INFO - 'SHLVL': '1', 02:22:44 INFO - 'TERM': 'linux', 02:22:44 INFO - 'TMOUT': '86400', 02:22:44 INFO - 'USER': 'cltbld', 02:22:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:44 INFO - '_': '/tools/buildbot/bin/python'} 02:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:22:44 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 02:22:44 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 02:22:44 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 02:22:44 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 02:22:44 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 02:22:44 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 02:22:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:22:46 INFO - Installing collected packages: mozsystemmonitor 02:22:46 INFO - Running setup.py install for mozsystemmonitor 02:22:46 INFO - Successfully installed mozsystemmonitor 02:22:46 INFO - Cleaning up... 02:22:46 INFO - Return code: 0 02:22:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:22:46 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')]} 02:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:46 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')]} 02:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:46 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 0x20fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', '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 02:22:46 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 02:22:46 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 02:22:46 INFO - Using env: {'DISPLAY': ':0', 02:22:46 INFO - 'HOME': '/home/cltbld', 02:22:46 INFO - 'LANG': 'en_US.UTF-8', 02:22:46 INFO - 'LANGUAGE': 'en_US:en', 02:22:46 INFO - 'LOGNAME': 'cltbld', 02:22:46 INFO - 'MAIL': '/var/mail/cltbld', 02:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:46 INFO - 'MOZ_NO_REMOTE': '1', 02:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:46 INFO - 'NO_EM_RESTART': '1', 02:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:46 INFO - 'PWD': '/builds/slave/test', 02:22:46 INFO - 'SHELL': '/bin/bash', 02:22:46 INFO - 'SHLVL': '1', 02:22:46 INFO - 'TERM': 'linux', 02:22:46 INFO - 'TMOUT': '86400', 02:22:46 INFO - 'USER': 'cltbld', 02:22:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:46 INFO - '_': '/tools/buildbot/bin/python'} 02:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:46 INFO - Downloading/unpacking jsonschema==2.5.1 02:22:46 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 02:22:46 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 02:22:46 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 02:22:46 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 02:22:46 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 02:22:46 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 02:22:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:22:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:48 INFO - Downloading functools32-3.2.3-2.tar.gz 02:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:22:48 INFO - warning: no files found matching '*.txt' 02:22:48 INFO - no previously-included directories found matching 'build' 02:22:48 INFO - no previously-included directories found matching 'dist' 02:22:48 INFO - no previously-included directories found matching '.git*' 02:22:48 INFO - Installing collected packages: jsonschema, functools32 02:22:48 INFO - Running setup.py install for functools32 02:22:49 INFO - warning: no files found matching '*.txt' 02:22:49 INFO - no previously-included directories found matching 'build' 02:22:49 INFO - no previously-included directories found matching 'dist' 02:22:49 INFO - no previously-included directories found matching '.git*' 02:22:49 INFO - Successfully installed jsonschema functools32 02:22:49 INFO - Cleaning up... 02:22:49 INFO - Return code: 0 02:22:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:22:49 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')]} 02:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:49 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')]} 02:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:49 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 0x20fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', '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 02:22:49 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 02:22:49 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 02:22:49 INFO - Using env: {'DISPLAY': ':0', 02:22:49 INFO - 'HOME': '/home/cltbld', 02:22:49 INFO - 'LANG': 'en_US.UTF-8', 02:22:49 INFO - 'LANGUAGE': 'en_US:en', 02:22:49 INFO - 'LOGNAME': 'cltbld', 02:22:49 INFO - 'MAIL': '/var/mail/cltbld', 02:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:49 INFO - 'MOZ_NO_REMOTE': '1', 02:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:49 INFO - 'NO_EM_RESTART': '1', 02:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:49 INFO - 'PWD': '/builds/slave/test', 02:22:49 INFO - 'SHELL': '/bin/bash', 02:22:49 INFO - 'SHLVL': '1', 02:22:49 INFO - 'TERM': 'linux', 02:22:49 INFO - 'TMOUT': '86400', 02:22:49 INFO - 'USER': 'cltbld', 02:22:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:49 INFO - '_': '/tools/buildbot/bin/python'} 02:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:22:49 INFO - Cleaning up... 02:22:49 INFO - Return code: 0 02:22:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22:49 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')]} 02:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:49 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')]} 02:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:49 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 0x20fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', '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 02:22:49 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 02:22:49 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 02:22:49 INFO - Using env: {'DISPLAY': ':0', 02:22:49 INFO - 'HOME': '/home/cltbld', 02:22:49 INFO - 'LANG': 'en_US.UTF-8', 02:22:49 INFO - 'LANGUAGE': 'en_US:en', 02:22:49 INFO - 'LOGNAME': 'cltbld', 02:22:49 INFO - 'MAIL': '/var/mail/cltbld', 02:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:49 INFO - 'MOZ_NO_REMOTE': '1', 02:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:49 INFO - 'NO_EM_RESTART': '1', 02:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:49 INFO - 'PWD': '/builds/slave/test', 02:22:49 INFO - 'SHELL': '/bin/bash', 02:22:49 INFO - 'SHLVL': '1', 02:22:49 INFO - 'TERM': 'linux', 02:22:49 INFO - 'TMOUT': '86400', 02:22:49 INFO - 'USER': 'cltbld', 02:22:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:49 INFO - '_': '/tools/buildbot/bin/python'} 02:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:49 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 02:22:49 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 02:22:49 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 02:22:49 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 02:22:49 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 02:22:49 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 02:22:51 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22:51 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 02:22:51 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 02:22:51 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 02:22:51 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 02:22:51 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 02:22:51 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 02:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:52 INFO - Downloading docopt-0.6.1.tar.gz 02:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:52 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:52 INFO - Running setup.py install for blobuploader 02:22:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:52 INFO - Running setup.py install for requests 02:22:52 INFO - Running setup.py install for docopt 02:22:52 INFO - Successfully installed blobuploader requests docopt 02:22:52 INFO - Cleaning up... 02:22:53 INFO - Return code: 0 02:22:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:53 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 0x20fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', '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 02:22:53 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 02:22:53 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 02:22:53 INFO - Using env: {'DISPLAY': ':0', 02:22:53 INFO - 'HOME': '/home/cltbld', 02:22:53 INFO - 'LANG': 'en_US.UTF-8', 02:22:53 INFO - 'LANGUAGE': 'en_US:en', 02:22:53 INFO - 'LOGNAME': 'cltbld', 02:22:53 INFO - 'MAIL': '/var/mail/cltbld', 02:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:53 INFO - 'MOZ_NO_REMOTE': '1', 02:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:53 INFO - 'NO_EM_RESTART': '1', 02:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:53 INFO - 'PWD': '/builds/slave/test', 02:22:53 INFO - 'SHELL': '/bin/bash', 02:22:53 INFO - 'SHLVL': '1', 02:22:53 INFO - 'TERM': 'linux', 02:22:53 INFO - 'TMOUT': '86400', 02:22:53 INFO - 'USER': 'cltbld', 02:22:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:53 INFO - '_': '/tools/buildbot/bin/python'} 02:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:53 INFO - Running setup.py (path:/tmp/pip-Q5QfhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:53 INFO - Running setup.py (path:/tmp/pip-2BydVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:53 INFO - Running setup.py (path:/tmp/pip-QArQh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:53 INFO - Running setup.py (path:/tmp/pip-SAID8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:53 INFO - Running setup.py (path:/tmp/pip-YaBuvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:53 INFO - Running setup.py (path:/tmp/pip-RD4yPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:53 INFO - Running setup.py (path:/tmp/pip-gRT9RO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:53 INFO - Running setup.py (path:/tmp/pip-L0DQ7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:53 INFO - Running setup.py (path:/tmp/pip-RMoXU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:53 INFO - Running setup.py (path:/tmp/pip-491irD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:53 INFO - Running setup.py (path:/tmp/pip-ZzitXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:54 INFO - Running setup.py (path:/tmp/pip-M4RRZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:54 INFO - Running setup.py (path:/tmp/pip-4h1jyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:54 INFO - Running setup.py (path:/tmp/pip-dXY_An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:54 INFO - Running setup.py (path:/tmp/pip-8IZlwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:54 INFO - Running setup.py (path:/tmp/pip-DSv8ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:54 INFO - Running setup.py (path:/tmp/pip-eI62aU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:22:54 INFO - Running setup.py install for manifestparser 02:22:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:22:54 INFO - Running setup.py install for mozcrash 02:22:54 INFO - Running setup.py install for mozdebug 02:22:54 INFO - Running setup.py install for mozdevice 02:22:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:22:54 INFO - Running setup.py install for mozfile 02:22:54 INFO - Running setup.py install for mozhttpd 02:22:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Running setup.py install for mozinfo 02:22:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Running setup.py install for mozInstall 02:22:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Running setup.py install for mozleak 02:22:55 INFO - Running setup.py install for mozlog 02:22:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Running setup.py install for moznetwork 02:22:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Running setup.py install for mozprocess 02:22:55 INFO - Running setup.py install for mozprofile 02:22:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Running setup.py install for mozrunner 02:22:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:22:55 INFO - Running setup.py install for mozscreenshot 02:22:56 INFO - Running setup.py install for moztest 02:22:56 INFO - Running setup.py install for mozversion 02:22:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:22:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:22:56 INFO - Cleaning up... 02:22:56 INFO - Return code: 0 02:22:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:56 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 0x20fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', '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 02:22:56 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 02:22:56 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 02:22:56 INFO - Using env: {'DISPLAY': ':0', 02:22:56 INFO - 'HOME': '/home/cltbld', 02:22:56 INFO - 'LANG': 'en_US.UTF-8', 02:22:56 INFO - 'LANGUAGE': 'en_US:en', 02:22:56 INFO - 'LOGNAME': 'cltbld', 02:22:56 INFO - 'MAIL': '/var/mail/cltbld', 02:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:56 INFO - 'MOZ_NO_REMOTE': '1', 02:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:56 INFO - 'NO_EM_RESTART': '1', 02:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:56 INFO - 'PWD': '/builds/slave/test', 02:22:56 INFO - 'SHELL': '/bin/bash', 02:22:56 INFO - 'SHLVL': '1', 02:22:56 INFO - 'TERM': 'linux', 02:22:56 INFO - 'TMOUT': '86400', 02:22:56 INFO - 'USER': 'cltbld', 02:22:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:56 INFO - '_': '/tools/buildbot/bin/python'} 02:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:56 INFO - Running setup.py (path:/tmp/pip-1QYhuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:56 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)) 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:56 INFO - Running setup.py (path:/tmp/pip-59qYeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:56 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)) 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:56 INFO - Running setup.py (path:/tmp/pip-65kO44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:56 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)) 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:56 INFO - Running setup.py (path:/tmp/pip-AnlPgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:56 INFO - Running setup.py (path:/tmp/pip-4upnS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:56 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)) 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:56 INFO - Running setup.py (path:/tmp/pip-7dfcaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:56 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)) 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:56 INFO - Running setup.py (path:/tmp/pip-QSLYHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:56 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)) 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:56 INFO - Running setup.py (path:/tmp/pip-hR5pAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:57 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)) 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:57 INFO - Running setup.py (path:/tmp/pip-t7W2WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:57 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)) 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:57 INFO - Running setup.py (path:/tmp/pip-seMkyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:57 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)) 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:57 INFO - Running setup.py (path:/tmp/pip-iiTnVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:57 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)) 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:57 INFO - Running setup.py (path:/tmp/pip-X1CQri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:57 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)) 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:57 INFO - Running setup.py (path:/tmp/pip-T0UPeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:57 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)) 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:57 INFO - Running setup.py (path:/tmp/pip-ME0EiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:57 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)) 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:57 INFO - Running setup.py (path:/tmp/pip-WEVq93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:57 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)) 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:57 INFO - Running setup.py (path:/tmp/pip-QZIBrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:57 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)) 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:57 INFO - Running setup.py (path:/tmp/pip-zudRPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:57 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)) 02:22:57 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)) 02:22:57 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)) 02:22:57 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)) 02:22:57 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:22:57 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:22:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:57 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 02:22:57 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 02:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:59 INFO - Downloading blessings-1.6.tar.gz 02:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:22:59 INFO - Installing collected packages: blessings 02:22:59 INFO - Running setup.py install for blessings 02:22:59 INFO - Successfully installed blessings 02:22:59 INFO - Cleaning up... 02:22:59 INFO - Return code: 0 02:22:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:22:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:00 INFO - Reading from file tmpfile_stdout 02:23:00 INFO - Current package versions: 02:23:00 INFO - argparse == 1.2.1 02:23:00 INFO - blessings == 1.6 02:23:00 INFO - blobuploader == 1.2.4 02:23:00 INFO - docopt == 0.6.1 02:23:00 INFO - functools32 == 3.2.3-2 02:23:00 INFO - jsonschema == 2.5.1 02:23:00 INFO - manifestparser == 1.1 02:23:00 INFO - mozInstall == 1.12 02:23:00 INFO - mozcrash == 1.0 02:23:00 INFO - mozdebug == 0.1 02:23:00 INFO - mozdevice == 0.50 02:23:00 INFO - mozfile == 1.2 02:23:00 INFO - mozhttpd == 0.7 02:23:00 INFO - mozinfo == 0.9 02:23:00 INFO - mozleak == 0.1 02:23:00 INFO - mozlog == 3.4 02:23:00 INFO - moznetwork == 0.27 02:23:00 INFO - mozprocess == 0.25 02:23:00 INFO - mozprofile == 0.28 02:23:00 INFO - mozrunner == 6.13 02:23:00 INFO - mozscreenshot == 0.1 02:23:00 INFO - mozsystemmonitor == 0.3 02:23:00 INFO - moztest == 0.8 02:23:00 INFO - mozversion == 1.4 02:23:00 INFO - psutil == 3.1.1 02:23:00 INFO - requests == 1.2.3 02:23:00 INFO - wsgiref == 0.1.2 02:23:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23: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')]} 02:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:00 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 0x20fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', '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 02:23:00 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 02:23:00 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 02:23:00 INFO - Using env: {'DISPLAY': ':0', 02:23:00 INFO - 'HOME': '/home/cltbld', 02:23:00 INFO - 'LANG': 'en_US.UTF-8', 02:23:00 INFO - 'LANGUAGE': 'en_US:en', 02:23:00 INFO - 'LOGNAME': 'cltbld', 02:23:00 INFO - 'MAIL': '/var/mail/cltbld', 02:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:00 INFO - 'MOZ_NO_REMOTE': '1', 02:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:00 INFO - 'NO_EM_RESTART': '1', 02:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:00 INFO - 'PWD': '/builds/slave/test', 02:23:00 INFO - 'SHELL': '/bin/bash', 02:23:00 INFO - 'SHLVL': '1', 02:23:00 INFO - 'TERM': 'linux', 02:23:00 INFO - 'TMOUT': '86400', 02:23:00 INFO - 'USER': 'cltbld', 02:23:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:00 INFO - '_': '/tools/buildbot/bin/python'} 02:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 INFO - Cleaning up... 02:23:00 INFO - Return code: 0 02:23:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:23: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')]} 02:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', '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 02:23: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', 'jsonschema'] in /builds/slave/test/build 02:23: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 jsonschema 02:23:00 INFO - Using env: {'DISPLAY': ':0', 02:23:00 INFO - 'HOME': '/home/cltbld', 02:23:00 INFO - 'LANG': 'en_US.UTF-8', 02:23:00 INFO - 'LANGUAGE': 'en_US:en', 02:23:00 INFO - 'LOGNAME': 'cltbld', 02:23:00 INFO - 'MAIL': '/var/mail/cltbld', 02:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:00 INFO - 'MOZ_NO_REMOTE': '1', 02:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:00 INFO - 'NO_EM_RESTART': '1', 02:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:00 INFO - 'PWD': '/builds/slave/test', 02:23:00 INFO - 'SHELL': '/bin/bash', 02:23:00 INFO - 'SHLVL': '1', 02:23:00 INFO - 'TERM': 'linux', 02:23:00 INFO - 'TMOUT': '86400', 02:23:00 INFO - 'USER': 'cltbld', 02:23:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:00 INFO - '_': '/tools/buildbot/bin/python'} 02:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:23:00 INFO - Cleaning up... 02:23:00 INFO - Return code: 0 02:23:00 INFO - Running post-action listener: _resource_record_post_action 02:23:00 INFO - Running post-action listener: _start_resource_monitoring 02:23:00 INFO - Starting resource monitoring. 02:23:00 INFO - [mozharness: 2017-04-18 09:23:00.681615Z] Finished create-virtualenv step (success) 02:23:00 INFO - [mozharness: 2017-04-18 09:23:00.682129Z] Running install step. 02:23:00 INFO - Running pre-action listener: _resource_record_pre_action 02:23:00 INFO - Running main action method: install 02:23:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:00 INFO - Reading from file tmpfile_stdout 02:23:00 INFO - Detecting whether we're running mozinstall >=1.0... 02:23:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:23:00 INFO - Reading from file tmpfile_stdout 02:23:00 INFO - Output received: 02:23:00 INFO - Usage: mozinstall [options] installer 02:23:00 INFO - Options: 02:23:00 INFO - -h, --help show this help message and exit 02:23:00 INFO - -d DEST, --destination=DEST 02:23:00 INFO - Directory to install application into. [default: 02:23:00 INFO - "/builds/slave/test"] 02:23:00 INFO - --app=APP Application being installed. [default: firefox] 02:23:00 INFO - mkdir: /builds/slave/test/build/application 02:23:00 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'] 02:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:23:17 INFO - Reading from file tmpfile_stdout 02:23:17 INFO - Output received: 02:23:17 INFO - /builds/slave/test/build/application/firefox/firefox 02:23:17 INFO - Running post-action listener: _resource_record_post_action 02:23:17 INFO - [mozharness: 2017-04-18 09:23:17.161894Z] Finished install step (success) 02:23:17 INFO - [mozharness: 2017-04-18 09:23:17.162172Z] Running run-tests step. 02:23:17 INFO - Running pre-action listener: _resource_record_pre_action 02:23:17 INFO - Running main action method: run_tests 02:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:23:17 INFO - Python 2.7.3 02:23:17 INFO - Return code: 0 02:23:17 INFO - grabbing minidump binary from tooltool 02:23: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')]} 02:23:17 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 0x2399400>, '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 0x239a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:23:17 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 02:23:17 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 02:23:17 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 02:23:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:23:17 INFO - Return code: 0 02:23:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:23:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:23:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:23:17 INFO - ENV: RUST_BACKTRACE is now 1 02:23:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:23:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 02:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 02:23:17 INFO - Using env: {'DISPLAY': ':0', 02:23:17 INFO - 'HOME': '/home/cltbld', 02:23:17 INFO - 'LANG': 'en_US.UTF-8', 02:23:17 INFO - 'LANGUAGE': 'en_US:en', 02:23:17 INFO - 'LOGNAME': 'cltbld', 02:23:17 INFO - 'MAIL': '/var/mail/cltbld', 02:23:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:23:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:17 INFO - 'MOZ_NO_REMOTE': '1', 02:23:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:17 INFO - 'NO_EM_RESTART': '1', 02:23:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:17 INFO - 'PWD': '/builds/slave/test', 02:23:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:23:17 INFO - 'RUST_BACKTRACE': '1', 02:23:17 INFO - 'SHELL': '/bin/bash', 02:23:17 INFO - 'SHLVL': '1', 02:23:17 INFO - 'TERM': 'linux', 02:23:17 INFO - 'TMOUT': '86400', 02:23:17 INFO - 'USER': 'cltbld', 02:23:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382', 02:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:17 INFO - '_': '/tools/buildbot/bin/python'} 02:23:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 02:23:17 INFO - mozversion application_buildid: 20170418082028 02:23:17 INFO - mozversion application_changeset: 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 02:23:17 INFO - mozversion application_display_name: Nightly 02:23:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:23:17 INFO - mozversion application_name: Firefox 02:23:17 INFO - mozversion application_remotingname: firefox 02:23:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:23:17 INFO - mozversion application_vendor: Mozilla 02:23:17 INFO - mozversion application_version: 55.0a1 02:23:17 INFO - mozversion platform_buildid: 20170418082028 02:23:17 INFO - mozversion platform_changeset: 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 02:23:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:23:17 INFO - mozversion platform_version: 55.0a1 02:23:17 INFO - using testdate: 1492507397 02:23:17 INFO - actual date: 1492507397 02:23:17 INFO - starting webserver on 'localhost:52597' 02:23:17 INFO - SUITE-START | Running 2 tests 02:23:17 INFO - TEST-START | dromaeo_css 02:23:17 INFO - operating with platform_type : linux_ 02:23:17 INFO - Initialising browser for dromaeo_css test... 02:23:17 INFO - TEST-INFO | started process 26897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3J_jsq/profile http://localhost:52597/getInfo.html) 02:23:21 INFO - PID 26897 | __metrics Screen width/height:1600/1200 02:23:21 INFO - PID 26897 | colorDepth:24 02:23:21 INFO - PID 26897 | Browser inner width/height: 1024/697 02:23:21 INFO - PID 26897 | __metrics 02:23:22 INFO - PID 26897 | 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" 02:23:22 INFO - PID 26897 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:23:24 INFO - TEST-INFO | 26897: exit 0 02:23:24 INFO - Browser initialized. 02:23:24 INFO - Running cycle 1/1 for dromaeo_css test... 02:23:24 INFO - TEST-INFO | started process 26995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3J_jsq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:35 INFO - PID 26995 | RSS: Main: 152494080 02:23:35 INFO - PID 26995 | 02:26:38 INFO - PID 26995 | Cycle 1(1): loaded http://localhost:52597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52597/tests/dromaeo/cssquery-ext.html) 02:26:39 INFO - PID 26995 | RSS: Main: 314118144 02:26:39 INFO - PID 26995 | 02:28:26 INFO - PID 26995 | ************************* 02:28:26 INFO - PID 26995 | A coding exception was thrown and uncaught in a Task. 02:28:26 INFO - PID 26995 | 02:28:26 ERROR - PID 26995 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:28:26 INFO - PID 26995 | Full stack: 02:28:26 INFO - PID 26995 | ************************* 02:28:26 INFO - PID 26995 | ************************* 02:28:26 INFO - PID 26995 | A coding exception was thrown and uncaught in a Task. 02:28:26 INFO - PID 26995 | 02:28:26 ERROR - PID 26995 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:28:26 INFO - PID 26995 | Full stack: 02:28:26 INFO - PID 26995 | ************************* 02:28:26 INFO - PID 26995 | ************************* 02:28:26 INFO - PID 26995 | A coding exception was thrown and uncaught in a Task. 02:28:26 INFO - PID 26995 | 02:28:26 ERROR - PID 26995 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:28:26 INFO - PID 26995 | Full stack: 02:28:26 INFO - PID 26995 | ************************* 02:28:26 INFO - PID 26995 | ************************* 02:28:26 INFO - PID 26995 | A coding exception was thrown and uncaught in a Task. 02:28:26 INFO - PID 26995 | 02:28:26 ERROR - PID 26995 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:28:26 INFO - PID 26995 | Full stack: 02:28:26 INFO - PID 26995 | ************************* 02:29:41 INFO - PID 26995 | Cycle 1(1): loaded http://localhost:52597/tests/dromaeo/cssquery-ext.html (next: http://localhost:52597/tests/dromaeo/cssquery-jquery.html) 02:29:42 INFO - PID 26995 | RSS: Main: 228589568 02:29:42 INFO - PID 26995 | 02:32:44 INFO - PID 26995 | Cycle 1(1): loaded http://localhost:52597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52597/tests/dromaeo/cssquery-mootools.html) 02:32:44 INFO - PID 26995 | RSS: Main: 176422912 02:32:44 INFO - PID 26995 | 02:35:46 INFO - PID 26995 | Cycle 1(1): loaded http://localhost:52597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52597/tests/dromaeo/cssquery-prototype.html) 02:35:47 INFO - PID 26995 | RSS: Main: 224616448 02:35:47 INFO - PID 26995 | 02:38:49 INFO - PID 26995 | Cycle 1(1): loaded http://localhost:52597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52597/tests/dromaeo/cssquery-yui.html) 02:38:50 INFO - PID 26995 | RSS: Main: 180445184 02:38:50 INFO - PID 26995 | 02:41:52 INFO - PID 26995 | Cycle 1(1): loaded http://localhost:52597/tests/dromaeo/cssquery-yui.html (next: http://localhost:52597/tests/dromaeo/cssquery-dojo.html) 02:41:52 INFO - PID 26995 | RSS: Main: 268288000 02:41:52 INFO - PID 26995 | 02:41:52 INFO - PID 26995 | __start_tp_report 02:41:52 INFO - PID 26995 | _x_x_mozilla_page_load 02:41:52 INFO - PID 26995 | _x_x_mozilla_page_load_details 02:41:52 INFO - PID 26995 | |i|pagename|runs| 02:41:52 INFO - PID 26995 | |0;dojo.html;3260.233845046414;3273.9686998595425;3283.8522266498035;3286.7041966223037;3331.2171639664675;5429.728513574325;5574.191742197389;5639.6334238274485;5719.914201286979;5744.16709577111;5593.580481463896;5652.830415087544;5674.971625141879;5733.913991290124;5742.794013257221;4879.828841078133;4923.286123512089;4965.056639238542;5039.974800125994;5091.745412729368;5039.269305950635;5059.6964182149;5100.209467532539;5109.978004399117;5137;4890.217565189588;4942.9011419771405;4952.257161425779;4961.553460188564;5034.446210916796;4982.950170498285;4992.6005919526715;4998.800047998076;5023.824166154203;5040.193569028937;4993.950060499385;5002.474740152305;5011.298418221452;5041.899162016776;5087.084324821531;5639.323281206241;5644.294463192101;5646.294213223306;5663.745131469093;5692.77228910843;5891.145783861316;5951.4048595140575;5955.642661440327;6127.356627554087;6129.325774164883;6105.43676973216;6159.81520554384;6161.661108639023;6173.783917562864;6174.320824709278;5707.286589176353;5727.828165155052;5743.052396354555;5750.654960702372;5751.942480575182;6126.050462178369;6322.178116844872;6325.4939604832425;6326.2724786649205;6337.936620633827;5929.140274660236;5997.790077347359;6059.121427393004;6062.9090563641585;6063.9090413643835;6119.228173263922;6163.044728067157;6163.907541386883;6168.814935551941;6183.041628547582;6092.634441933498;6139.570230083851;6151.108089327112;6153.876922461615;6158.969205154035;5949.970250148808;6022.728977196037;6107.755689772448;6123.65904821696;6131.877362452726;4661.347411362412;4664.277037059262;4666.043461090469;4698.412698412699;4717.764111794397;4169.687273454503;4172.7079104463;4176.352665336878;4190.287651099259;4226.302660061117;5551.500364967092;5620.5503559715125;5669.177969194444;5730.455606717355;5819.76720931158;6040.939590604125;6065.575409721366;6088.1476593276975;6106.126990750318;6137.110119032715;5625.184348269478;5629.971850140723;5631.267935168484;5632.690202038927;5637.379888212294;5072.974635126875;5181.5595674368105;5188.792448302026;5248.05535003703;5307.150855863043;6373.3945275198785;6444.677766111582;6453.064305675744;6458.2895881453005;6459;6107.633541987495;6129.84675383119;6143.201383820075;6144.324124346229;6170.352113028068;6112.625067133501;6191.597546159485;6286.52851036165;6373.139626150411;6373.3945275198785;6092.939070609415;6094.229520225711;6096;6120.724567394389;6127.877442451215;6121.234845644294;6140.662263575367;6162.4399730126315;6187.721552530237;6195.19462469876;5815.331236907809;5856.824295271149;5873.9412605873395;6010.729517171825;6062.757489700539;5894.0274854648505;5912.46787789101;5916.467517923407;5918.940810591839;5919.6152250103605;5858.94141058584;5869.295684517885;5871.442212989759;5932.2584676915385;5976.342602313829;6044.818655440344;6051.1830902829315;6052.455279024909;6058.3335833057445;6074.362191969956;5863.824085277449;5868.3251426086545;5876.882462350643;5879.088741245114;5898.734556944862 02:41:52 INFO - PID 26995 | |1;ext.html;675.7161991963375;743.3532826440995;759.8328367759093;1129.8135807591748;1145.9942700286497;30949;39093.413598796;39710.81590512521;39782;39826.60173398265;41837.16325673485;42167.578324216745;42220.78889605555;42279;42283.15433691324;6062.242219722535;6204.386859416539;8148.022237331528;8299.502029878196;8304.792380190484;8046.235607617296;8187.5087494750205;8214.671413143467;8215.26062654361;8221.260086592205;8391.035030971425;8483.95758021209;8485.915140848574;8492;8497.61760720766;8384.748457546284;8416.789580260513;8429.831403371898;8430.747077587683;8431.789205269917;8247.092819789817;8305.169483051706;8316.085230624627;8318.66725330986;8319.376046796455;40417.19165616671;40618;40678.79660601678;40722;40780.59219407827;3480.3561341151967;3508.8245587720767;3511.7541772075965;3521.683048525645;3522.18989632386;31696.207594810083;31725.20686982821;31788.36423271545;31796.364072718417;31803.84098079518;3986.820593073319;3992.960070399288;3995.5005624296964;3999.6600288975474;4017.979910100431;195899;196731;196953.99999999857;196972;197199.1400429973;48203;48405;48591.757041214565;48605.756971215626;48610.75694621504;50138;50398.244026339635;50745.74627126915;50805.745971269906;50844;14138;14240.074395164282;14243.572692819233;14244.216568088646;14261.42954281817;9581.089796469463;9724.270679699051;11031.393273369882;11374.886251137383;11378.544858205745;12789.808152877715;12959.805602915963;13017.609471715863;13090.410931508104;13174.73650526984;5129.8204562840865;5179.700848295905;5218.947810521922;5221.973890130525;5227.92158117621;1055.8416237564272;1106.1206340958956;1114.4984756859446;1132.5300000499865;1137.647329327911;31654.52518212229;32057.839710801298;32309.35381292361;32381.838090809866;32849.67150328466;1161.8896204860525;1162.5698491558178;1164.1094562659573;1180.6576092933126;1200.39980009995;13544.390502427217;13876.306184690726;13950;14087;14136.71726565463;239274;239755;239822;240329;241012;52398.47601524012;52444.47555524396;52531.47468525266;52576;52731.736341318814;1406.5006922542555;1465.4065103633045;1480.8667219950041;1491.4779827060659;1499.235389951111;23399;24312;24929.376765581004;24984.375390614652;25102.874485627453;38641.22717545577;38659;38667.419988700756;38671.80664096774;38749.41875871808;216110;216812;216935;216961;216970;32822;32907.341853163285;33798.83100584481;34288.31423371568;34525.82737086399;42594.57405425906;43159.05784239779;43195.136097278504;43736.343954840064;43802.49580033653;31853.018372703413;32025.199370015005;32151.517727233644;32861;32942.67057329396;31243.062708118792;31325.686743132275;31435.528467072556;31706;32304.83847580747;37998;37999.24001520009;38082.809585951894;38371.42442863415;40304.3954340691;31154.37691246117;32022;32356.676433235367;33195;33886.491702623985;25428;26395.472090558465;26793;26842.865785670947;27250.727492724818 02:41:52 INFO - PID 26995 | |2;jquery.html;369.0588998054959;390.41827676761613;394.81049096433713;404.18556608434;410.07118875746437;14218.431262749491;16588.585285367855;20089.899550502247;21950.231741889038;21994.4501387465;21851.453713657167;22010;22473.55052898941;22651.320460386174;22737.772622273773;5692.857678558048;5744.856378590527;5867.501262392701;5890.204822348992;5904.675242861641;3530.117470632329;3696.242270334575;5793.739281732311;5910.67491287979;5912.2018527498885;5647.745851436695;5842.649441033552;5865.560082993771;5876.030454974924;5881.5294776417995;5674.829755107354;5735.541156707495;5810.941890581083;5876.676782776945;5879.176915231871;5144.536991670768;5146.150885103953;5148.3564554430695;5153.56194723449;5153.819616313449;24444;25562.87218563914;25615.48769024609;25678.101266455586;25790.226293211235;2184.8252139828774;2208.856424332413;2219;2222.8999695013604;2225.3101538522947;16580.668386632322;17390.826091739047;17394.565135871577;17457.301707931667;17539.73690394645;2253.504229069602;2297.8621282722925;2319.8724070176304;2321.6981792367055;2349.424391024193;111224.4438777801;117630;118213;119141;123202.76797232003;20063.197472100954;20659.79340206579;20814.895925520275;21067.575809080266;21287.8935605321;38533.22933541313;38602.42096368557;38670;39016.414753778714;39142;8086.595670216466;8106.310963568163;8340.207680270365;8464.957675211708;8578.313734901192;7915.208479152038;7938.650429427012;8016.759497214976;8142.674293028331;8157.265846073882;7403.815389537755;7513.962430187923;7538.359239464707;7597.278258565428;7623.733169339157;1950.9024548772788;1991.8705284156483;1993.5414854583528;2000.0799632169364;2127.5957568062017;1026.3636545341787;1062.2670357453487;1072.2147624205766;1073.7798751255973;1075.1506310015156;23533.529329413315;26359;26433.867830660725;26630.20109396721;26753.19740407791;1087.374759513283;1097.6048622495896;1097.7091070866227;1104.2049724198564;1126.1778901402022;11445;11987.760244795056;12018.639440816789;12043.518259269706;12069.336186509827;538731;543705;544858;550862;551091;100205.49897250468;101551;101923.49038254909;103358.48320758498;105819;1265.8354413926131;1289.509986205236;1291.3801375339701;1295.520657356784;1301.284293638495;17961.371352002618;18268.177931992825;18519.166637501075;18591.256349745858;18648.533786655444;49164.50835491742;49606.27952903474;49818.75090624524;50166;50478;62562.68718656377;62937;63141.68429157825;63788;64546.35453645403;8760.956195218983;8801.339899507435;9027.819443611223;9176.35765496409;9630.47032413224;14828.481003164838;15733.606659833596;15889.761653575437;16373;16427.83572164263;13591.728165436438;13601.931990339985;13698.109622874481;13764.93117534406;13805;12493.750124997267;12746.298953557643;12796.232226066466;12971.156874803108;13448.26034568069;13385.799213012007;13941.442342306194;14095.436182552583;14147.787783183054;14294.571162865132;9004.774880628036;9184.816303674022;9196.908030919873;9294.442333460014;9468.384555003902;13405.664858378228;13895.30523473802;13977.58067257984;14080.647983800487;14121.505747298796 02:41:52 INFO - PID 26995 | |3;mootools.html;1329.1626275446467;1354.288998275905;1402.3479082226768;1410.8871290296777;1419.7586410310246;10783.299085559443;11203;11214.215004949658;11215.327080375173;11225.550977960882;10811.405372704497;10847;11357.602483913064;11397.430128493563;11403;2393.15043159678;2427.9514409711796;2432.8661923594195;2434.610462326028;2436.561418944589;2152.268228802207;2230.152542034025;2236.686863839064;2243.14760391052;2365.7515960824126;1918.9232430702825;1996.670549359354;1997.0314397517266;1997.4906398868268;2278.3734473019886;2243.697100891375;2271.716035495563;2271.7387500437494;2274.158561332301;2274.624686926655;2285.1544928376443;2296.4488522754586;2297.977020229793;2315.409570559513;2375.168690958168;10992;11100.61147859821;11100.833487497694;11112.16658750597;11117.388543630097;6303.905441418382;6519.380658837403;6526.608403495758;6528.445082168021;6531.510136739716;3938.133610605662;4104.220198162339;4156.633127167004;4195.077083041726;4241.512226094008;1362.9318534073257;1374.780035194374;1387.1469046536308;1409.767388380916;1441.2577522575882;16030.919845400698;16184.35262589495;16212.513624591282;16212.675746485003;16236;5083.644144909821;5161.4322424533275;5378.838634840961;5396.08266594672;5445.50990410865;11919.284842909454;11960.162788604714;11961.40192990347;11976.221545599508;11979.005248687828;6332.366763323631;6333.1766870306565;6343.27052388972;6349.6507692077375;6351.491880649537;5744.396838331999;5815.331236907809;5853.122031695195;5860.912086318709;5868.559858010666;4064.552899181088;4147.730397524211;4202.054537728986;4221.704480686384;4253.21315556623;1208.957686480969;1215.769003889258;1228.2200802490304;1233.5559198688466;1235.7034311765112;833.5957060825494;852.3479538153317;867.6225841758855;874.0822136756508;897.3270047464401;6016.669083200379;6059.303180134341;6072.817815465543;6147.66187859663;6271.122042913996;606.3814908793006;618.038949433635;623.8596315828993;629.2889035390072;629.9527535434861;3821.7133714971487;4216.3464662977285;4272.46594175728;4348.369486424451;4416.734995900256;13783.379747911167;14554.563363099123;14556.927215363856;14575.927120364331;14607.92696036513;14323.928380358031;14334.068285561405;14363.56909292723;14371.640708982359;14377.065490743278;8857.955710221408;9265.953670231605;9318.301127415336;9329.953350233205;9356.532173391302;6244.500439964882;6299.937000630119;6314.589551679126;6338.936610634019;6456.612603243821;12752.936235318764;12767.80848287295;12799.552015679406;12920.35398230066;13268.336583170996;13159;13260.933695331461;13269.469221231042;13294.867051329364;13471.865281347453;9144.131307525775;9319.906800931903;9323.393979391589;9327.81344373095;9410.38832475887;10357.689269321932;10390.688279351632;10439.58241670355;10440.63457778974;10444.373337599769;8506.362022848434;8686.739397818075;8758.343124265833;8758.430702004349;8934.910650893407;8190.262876341158;8283.213094755989;8303.501789892625;8318.334533237448;8329.250367466957;7283.708651653875;7388.704451821867;7390.408767298496;7399.741009064657;7405.925940740523;5528;5555.194496798023;5613.101903695389;5682.488576028178;5730.255066841284;5346.647475110939;5405.621606487508;5429.701366424727;5519.586031047767;5564.610477266552 02:41:52 INFO - PID 26995 | |4;prototype.html;373.19390117346535;386.21020014071206;386.341288103783;387.79640688638443;388.3921662598034;5562.499375056244;5689.562141529603;5821.301443826741;5838.532917366606;5857.589968702187;5579.191017302489;5664.640486283293;5677.9716101419535;5690.374058853523;5730.971345143279;4408.603225709678;4411.867643970686;4416.315471101984;4424.601785839274;4424.712393694415;4154.854580089697;4284.614384705376;4290.6352959998285;4416.293393057112;4427.800748966288;4264.104538047014;4298.161858437606;4304.504981927072;4307.547707490716;4314.417553630251;4298.011457364808;4302.870913872589;4305.483341998949;4305.870823875289;4315.4821421429315;3763.172102137525;3766.152615661482;3769.5288088988877;3776.4901738265257;3844.942325865114;5541.778328866841;5559.9444005559835;5573.554115670737;5638.026690658277;5642.238297829782;5227.503387178212;5249.658772179796;5252.480837838657;5260.710660913648;5270;5949.286085669704;6035.849103772441;6103.314541601681;6132;6143.569950103494;4445.799939002753;4462.12988467249;4467.597916187527;4468.50846406895;4469.955300446986;6415.518836087312;6429.678516074225;6458.806235812933;6469.32072132424;6501.6749162542155;4385.583369579885;4515.796789144496;4518.728876267369;4519.502854685982;4560.110778398247;4582.770861456914;4590.163934426256;4591.668416159343;4603.95396046042;4609.746463944448;5215.947840521622;5216.4522725114075;5216.556592689588;5228.55557277628;5237.633365664443;5860.3260625027815;5871.2073870027;6065.211522502046;6117.204763380732;6171.444569988723;1512.3648067811546;1561.5315405378342;1595.6728870581503;1602.262959038832;1603.0862408427317;1080.7298175456135;1112.5772206561455;1117.5753213778873;1118.4351902289293;1122.5341483284508;5781.364049954502;5803.881583222178;5833.766649333979;5839.941600583939;5867.178594996704;6160.260768707783;6193.81418557444;6232.594881332699;6238.313785483593;6286.748530058838;5633.070543360382;5851.473367396955;5873.530117590582;5894.204282421904;5901.645901245939;3295.703386695161;3332.250243695149;3333.449980753197;3337.6495467975997;3351.379994700988;6271.6550589718;6400.55196136266;6444.387783160592;6491.610503369813;6508.837279068061;6381.266154392304;6404.871902561923;6412.262589802139;6418.1656384669695;6458.644774537352;6234.350401079614;6446.065320528497;6468.3855033771715;6483.003222019613;6504.121943537656;6247.750089996349;6284.811455656338;6287.654179020014;6304.3380445054445;6311.116443697978;6256.530760192913;6265.874682506415;6271.560990730787;6290.685465726604;6312.715927783169;6327.147388665558;6487.643179625166;6506.316836732264;6528.249251336157;6534.248561415308;4309.116631090682;4315.8489452869;4317.568243175658;4324.502682191588;4341.088371442032;5908.1137829324225;5915.585908986502;6336.493080553452;6344;6362.6818659067785;6061.39386061408;6102.481289090477;6104.4505994460715;6114.419130182626;6138.693065346625;6074.635521868702;6093.756249750138;6152.538559608137;6163.7842675506145;6165.84585385369;5885.499732522783;6034.577579569388;6091.451769340781;6096.29892562361;6098.695065246631;6073.817785466443;6095.1466794647895;6108.328083910677;6119.877602448015;6139.263288405241;5755.7409916553015;5904.881902361843;5967.9701601491715;5968.701564921824;5975.40245975399 02:41:52 INFO - PID 26995 | |5;yui.html;697.9720811167554;867.5662168915542;876.3077169036461;882.1178821178821;883.2271762208068;13250.66873328166;16079.276432560533;16918.40785572505;16937;17021.31914723411;16781.580460488465;17388.82611173888;17449.214785334658;17580.736288955675;17601.55996100098;981.4700061966547;1023.4575674892319;1027.4503140819663;1028.4754775064735;1028.6399760083987;734.2657342657343;1040.069138121381;1043.0247718383298;1043.8799538053106;1044.7335929338008;802.2178376083331;1026.6714651311584;1053.3627155570884;1058.4125810175349;1059.9629012984547;1029.402946291157;1039.365986748087;1039.7140786283758;1040.3861721584265;1041.167066346927;556.2129586634907;764.6176911544228;764.6826566974698;764.7055883484843;765.0857225615392;12923.935380323132;16691.41580044705;17366.305347786074;17426;17466.126693665392;17915;18687;18740.625187496174;18813.15340809667;18901.243950241973;14874;15094.773578396223;15096;15131.470398536108;15135.318910649048;3574.267275208576;3620.818959052037;3625.0393645683916;3629.038304849217;3630.981845090784;86521.56739216327;88101.55949220277;90318;91052;91192.54403728005;11385.829212561819;15071.623209419633;15463.149526775911;15598.454054108051;15633.374665013273;19481.805181948283;25878.22365329043;25881.870590646926;25962.740372596032;26814.463710726068;8523.318134549221;8679.913200868037;8694.304455643532;8700.608472618747;8716.346274029473;4221.113566151143;4310.245707001262;4311.267084595626;4351.08627188294;4412.889677758082;4285.335772955197;4343.913121737548;4350.086481838849;4366.6506679465565;4370.912581748347;886.7339798060556;893.3835653399134;901.1664210605164;903.8960519540205;904.2178515584104;635.3265538529174;650.0801366067057;653.3531803514581;662.1689779326914;663.6648492511348;10763.569457221623;11096.722581935515;11521.423928803526;11784.764304713857;11869.762604747857;604.8880957022965;605.6668832142392;607.7660100861112;614.9508039356841;620.4725982914576;5144.742762861842;5211.609129315317;5419.3225846769155;5479.123340265538;5480.177973304037;74128;75586.24413755901;76189.23810761822;76199;76601;66858.66570667212;68521;68715;68786.65606671934;69850.3014969854;61241.693791531645;62050.0692489604;62112.378876210656;62262.68868655628;63200.683996579726;11268;12176.507147296457;12195.146339756131;12206.633800985985;12259.448324825225;33199;33540.66459335375;33799.3240135191;34131.14672133117;35976.10059748423;39132.413013804246;39410.211795764495;40033.599664002984;40641.13909178623;41539;15751.369945202521;16028.27872745706;16101.75847362267;16151.434699785452;16390.344386224417;17189.656206876043;17627.82372176262;17724.91137544304;17727;18089.095545222423;16542.503724888273;16627;17448.82551174472;17511.737323939895;18141.546461338574;15259.694806104038;15461.226938652797;15536.30086646081;16775.328986840388;16923.57691057684;15625;16466.09436481005;16735.748963765796;16817.915910420368;16964.915175424045;10538.789224215627;10675.626353077605;10815.405152716676;12155.599603567889;12280.32458214771;13255.933720331337;13839.723205536035;13921.79117313221;14180.645483862985;14271.357788899732 02:41:52 INFO - PID 26995 | __end_tp_report 02:41:52 INFO - PID 26995 | __start_cc_report 02:41:52 INFO - PID 26995 | _x_x_mozilla_cycle_collect,1559 02:41:52 INFO - PID 26995 | __end_cc_report 02:41:52 INFO - PID 26995 | __startTimestamp1492508512722__endTimestamp 02:41:52 INFO - PID 26995 | 02:41:52 INFO - PID 26995 | ------- Summary: start ------- 02:41:52 INFO - PID 26995 | Number of tests: 6 02:41:52 INFO - PID 26995 | 02:41:52 INFO - PID 26995 | [#0] dojo.html Cycles:165 Average:5640.41 Median:5873.94 stddev:674.91 (11.5%) stddev-sans-first:650.64 02:41:52 INFO - PID 26995 | Values: 3260.2 3274.0 3283.9 3286.7 3331.2 5429.7 5574.2 5639.6 5719.9 5744.2 5593.6 5652.8 5675.0 5733.9 5742.8 4879.8 4923.3 4965.1 5040.0 5091.7 5039.3 5059.7 5100.2 5110.0 5137.0 4890.2 4942.9 4952.3 4961.6 5034.4 4983.0 4992.6 4998.8 5023.8 5040.2 4994.0 5002.5 5011.3 5041.9 5087.1 5639.3 5644.3 5646.3 5663.7 5692.8 5891.1 5951.4 5955.6 6127.4 6129.3 6105.4 6159.8 6161.7 6173.8 6174.3 5707.3 5727.8 5743.1 5750.7 5751.9 6126.1 6322.2 6325.5 6326.3 6337.9 5929.1 5997.8 6059.1 6062.9 6063.9 6119.2 6163.0 6163.9 6168.8 6183.0 6092.6 6139.6 6151.1 6153.9 6159.0 5950.0 6022.7 6107.8 6123.7 6131.9 4661.3 4664.3 4666.0 4698.4 4717.8 4169.7 4172.7 4176.4 4190.3 4226.3 5551.5 5620.6 5669.2 5730.5 5819.8 6040.9 6065.6 6088.1 6106.1 6137.1 5625.2 5630.0 5631.3 5632.7 5637.4 5073.0 5181.6 5188.8 5248.1 5307.2 6373.4 6444.7 6453.1 6458.3 6459.0 6107.6 6129.8 6143.2 6144.3 6170.4 6112.6 6191.6 6286.5 6373.1 6373.4 6092.9 6094.2 6096.0 6120.7 6127.9 6121.2 6140.7 6162.4 6187.7 6195.2 5815.3 5856.8 5873.9 6010.7 6062.8 5894.0 5912.5 5916.5 5918.9 5919.6 5858.9 5869.3 5871.4 5932.3 5976.3 6044.8 6051.2 6052.5 6058.3 6074.4 5863.8 5868.3 5876.9 5879.1 5898.7 02:41:52 INFO - PID 26995 | 02:41:52 INFO - PID 26995 | [#1] ext.html Cycles:180 Average:38930.55 Median:19003.09 stddev:56634.19 (298.0%) stddev-sans-first:56720.22 02:41:52 INFO - PID 26995 | Values: 675.7 743.4 759.8 1129.8 1146.0 30949.0 39093.4 39710.8 39782.0 39826.6 41837.2 42167.6 42220.8 42279.0 42283.2 6062.2 6204.4 8148.0 8299.5 8304.8 8046.2 8187.5 8214.7 8215.3 8221.3 8391.0 8484.0 8485.9 8492.0 8497.6 8384.7 8416.8 8429.8 8430.7 8431.8 8247.1 8305.2 8316.1 8318.7 8319.4 40417.2 40618.0 40678.8 40722.0 40780.6 3480.4 3508.8 3511.8 3521.7 3522.2 31696.2 31725.2 31788.4 31796.4 31803.8 3986.8 3993.0 3995.5 3999.7 4018.0 195899.0 196731.0 196954.0 196972.0 197199.1 48203.0 48405.0 48591.8 48605.8 48610.8 50138.0 50398.2 50745.7 50805.7 50844.0 14138.0 14240.1 14243.6 14244.2 14261.4 9581.1 9724.3 11031.4 11374.9 11378.5 12789.8 12959.8 13017.6 13090.4 13174.7 5129.8 5179.7 5218.9 5222.0 5227.9 1055.8 1106.1 1114.5 1132.5 1137.6 31654.5 32057.8 32309.4 32381.8 32849.7 1161.9 1162.6 1164.1 1180.7 1200.4 13544.4 13876.3 13950.0 14087.0 14136.7 239274.0 239755.0 239822.0 240329.0 241012.0 52398.5 52444.5 52531.5 52576.0 52731.7 1406.5 1465.4 1480.9 1491.5 1499.2 23399.0 24312.0 24929.4 24984.4 25102.9 38641.2 38659.0 38667.4 38671.8 38749.4 216110.0 216812.0 216935.0 216961.0 216970.0 32822.0 32907.3 33798.8 34288.3 34525.8 42594.6 43159.1 43195.1 43736.3 43802.5 31853.0 32025.2 32151.5 32861.0 32942.7 31243.1 31325.7 31435.5 31706.0 32304.8 37998.0 37999.2 38082.8 38371.4 40304.4 31154.4 32022.0 32356.7 33195.0 33886.5 25428.0 26395.5 26793.0 26842.9 27250.7 02:41:52 INFO - PID 26995 | 02:41:52 INFO - PID 26995 | [#2] jquery.html Cycles:180 Average:34161.29 Median:12517.82 stddev:90518.57 (723.1%) stddev-sans-first:90736.94 02:41:52 INFO - PID 26995 | Values: 369.1 390.4 394.8 404.2 410.1 14218.4 16588.6 20089.9 21950.2 21994.5 21851.5 22010.0 22473.6 22651.3 22737.8 5692.9 5744.9 5867.5 5890.2 5904.7 3530.1 3696.2 5793.7 5910.7 5912.2 5647.7 5842.6 5865.6 5876.0 5881.5 5674.8 5735.5 5810.9 5876.7 5879.2 5144.5 5146.2 5148.4 5153.6 5153.8 24444.0 25562.9 25615.5 25678.1 25790.2 2184.8 2208.9 2219.0 2222.9 2225.3 16580.7 17390.8 17394.6 17457.3 17539.7 2253.5 2297.9 2319.9 2321.7 2349.4 111224.4 117630.0 118213.0 119141.0 123202.8 20063.2 20659.8 20814.9 21067.6 21287.9 38533.2 38602.4 38670.0 39016.4 39142.0 8086.6 8106.3 8340.2 8465.0 8578.3 7915.2 7938.7 8016.8 8142.7 8157.3 7403.8 7514.0 7538.4 7597.3 7623.7 1950.9 1991.9 1993.5 2000.1 2127.6 1026.4 1062.3 1072.2 1073.8 1075.2 23533.5 26359.0 26433.9 26630.2 26753.2 1087.4 1097.6 1097.7 1104.2 1126.2 11445.0 11987.8 12018.6 12043.5 12069.3 538731.0 543705.0 544858.0 550862.0 551091.0 100205.5 101551.0 101923.5 103358.5 105819.0 1265.8 1289.5 1291.4 1295.5 1301.3 17961.4 18268.2 18519.2 18591.3 18648.5 49164.5 49606.3 49818.8 50166.0 50478.0 62562.7 62937.0 63141.7 63788.0 64546.4 8761.0 8801.3 9027.8 9176.4 9630.5 14828.5 15733.6 15889.8 16373.0 16427.8 13591.7 13601.9 13698.1 13764.9 13805.0 12493.8 12746.3 12796.2 12971.2 13448.3 13385.8 13941.4 14095.4 14147.8 14294.6 9004.8 9184.8 9196.9 9294.4 9468.4 13405.7 13895.3 13977.6 14080.6 14121.5 02:41:52 INFO - PID 26995 | 02:41:52 INFO - PID 26995 | [#3] mootools.html Cycles:180 Average:6849.18 Median:3879.92 stddev:4394.40 (113.3%) stddev-sans-first:4387.15 02:41:52 INFO - PID 26995 | Values: 1329.2 1354.3 1402.3 1410.9 1419.8 10783.3 11203.0 11214.2 11215.3 11225.6 10811.4 10847.0 11357.6 11397.4 11403.0 2393.2 2428.0 2432.9 2434.6 2436.6 2152.3 2230.2 2236.7 2243.1 2365.8 1918.9 1996.7 1997.0 1997.5 2278.4 2243.7 2271.7 2271.7 2274.2 2274.6 2285.2 2296.4 2298.0 2315.4 2375.2 10992.0 11100.6 11100.8 11112.2 11117.4 6303.9 6519.4 6526.6 6528.4 6531.5 3938.1 4104.2 4156.6 4195.1 4241.5 1362.9 1374.8 1387.1 1409.8 1441.3 16030.9 16184.4 16212.5 16212.7 16236.0 5083.6 5161.4 5378.8 5396.1 5445.5 11919.3 11960.2 11961.4 11976.2 11979.0 6332.4 6333.2 6343.3 6349.7 6351.5 5744.4 5815.3 5853.1 5860.9 5868.6 4064.6 4147.7 4202.1 4221.7 4253.2 1209.0 1215.8 1228.2 1233.6 1235.7 833.6 852.3 867.6 874.1 897.3 6016.7 6059.3 6072.8 6147.7 6271.1 606.4 618.0 623.9 629.3 630.0 3821.7 4216.3 4272.5 4348.4 4416.7 13783.4 14554.6 14556.9 14575.9 14607.9 14323.9 14334.1 14363.6 14371.6 14377.1 8858.0 9266.0 9318.3 9330.0 9356.5 6244.5 6299.9 6314.6 6338.9 6456.6 12752.9 12767.8 12799.6 12920.4 13268.3 13159.0 13260.9 13269.5 13294.9 13471.9 9144.1 9319.9 9323.4 9327.8 9410.4 10357.7 10390.7 10439.6 10440.6 10444.4 8506.4 8686.7 8758.3 8758.4 8934.9 8190.3 8283.2 8303.5 8318.3 8329.3 7283.7 7388.7 7390.4 7399.7 7405.9 5528.0 5555.2 5613.1 5682.5 5730.3 5346.6 5405.6 5429.7 5519.6 5564.6 02:41:52 INFO - PID 26995 | 02:41:52 INFO - PID 26995 | [#4] prototype.html Cycles:180 Average:5113.64 Median:5812.59 stddev:1515.97 (26.1%) stddev-sans-first:1477.88 02:41:52 INFO - PID 26995 | Values: 373.2 386.2 386.3 387.8 388.4 5562.5 5689.6 5821.3 5838.5 5857.6 5579.2 5664.6 5678.0 5690.4 5731.0 4408.6 4411.9 4416.3 4424.6 4424.7 4154.9 4284.6 4290.6 4416.3 4427.8 4264.1 4298.2 4304.5 4307.5 4314.4 4298.0 4302.9 4305.5 4305.9 4315.5 3763.2 3766.2 3769.5 3776.5 3844.9 5541.8 5559.9 5573.6 5638.0 5642.2 5227.5 5249.7 5252.5 5260.7 5270.0 5949.3 6035.8 6103.3 6132.0 6143.6 4445.8 4462.1 4467.6 4468.5 4470.0 6415.5 6429.7 6458.8 6469.3 6501.7 4385.6 4515.8 4518.7 4519.5 4560.1 4582.8 4590.2 4591.7 4604.0 4609.7 5215.9 5216.5 5216.6 5228.6 5237.6 5860.3 5871.2 6065.2 6117.2 6171.4 1512.4 1561.5 1595.7 1602.3 1603.1 1080.7 1112.6 1117.6 1118.4 1122.5 5781.4 5803.9 5833.8 5839.9 5867.2 6160.3 6193.8 6232.6 6238.3 6286.7 5633.1 5851.5 5873.5 5894.2 5901.6 3295.7 3332.3 3333.4 3337.6 3351.4 6271.7 6400.6 6444.4 6491.6 6508.8 6381.3 6404.9 6412.3 6418.2 6458.6 6234.4 6446.1 6468.4 6483.0 6504.1 6247.8 6284.8 6287.7 6304.3 6311.1 6256.5 6265.9 6271.6 6290.7 6312.7 6327.1 6487.6 6506.3 6528.2 6534.2 4309.1 4315.8 4317.6 4324.5 4341.1 5908.1 5915.6 6336.5 6344.0 6362.7 6061.4 6102.5 6104.5 6114.4 6138.7 6074.6 6093.8 6152.5 6163.8 6165.8 5885.5 6034.6 6091.5 6096.3 6098.7 6073.8 6095.1 6108.3 6119.9 6139.3 5755.7 5904.9 5968.0 5968.7 5975.4 02:41:52 INFO - PID 26995 | 02:41:52 INFO - PID 26995 | [#5] yui.html Cycles:180 Average:18312.77 Median:18857.20 stddev:22053.63 (117.0%) stddev-sans-first:22075.83 02:41:52 INFO - PID 26995 | Values: 698.0 867.6 876.3 882.1 883.2 13250.7 16079.3 16918.4 16937.0 17021.3 16781.6 17388.8 17449.2 17580.7 17601.6 981.5 1023.5 1027.5 1028.5 1028.6 734.3 1040.1 1043.0 1043.9 1044.7 802.2 1026.7 1053.4 1058.4 1060.0 1029.4 1039.4 1039.7 1040.4 1041.2 556.2 764.6 764.7 764.7 765.1 12923.9 16691.4 17366.3 17426.0 17466.1 17915.0 18687.0 18740.6 18813.2 18901.2 14874.0 15094.8 15096.0 15131.5 15135.3 3574.3 3620.8 3625.0 3629.0 3631.0 86521.6 88101.6 90318.0 91052.0 91192.5 11385.8 15071.6 15463.1 15598.5 15633.4 19481.8 25878.2 25881.9 25962.7 26814.5 8523.3 8679.9 8694.3 8700.6 8716.3 4221.1 4310.2 4311.3 4351.1 4412.9 4285.3 4343.9 4350.1 4366.7 4370.9 886.7 893.4 901.2 903.9 904.2 635.3 650.1 653.4 662.2 663.7 10763.6 11096.7 11521.4 11784.8 11869.8 604.9 605.7 607.8 615.0 620.5 5144.7 5211.6 5419.3 5479.1 5480.2 74128.0 75586.2 76189.2 76199.0 76601.0 66858.7 68521.0 68715.0 68786.7 69850.3 61241.7 62050.1 62112.4 62262.7 63200.7 11268.0 12176.5 12195.1 12206.6 12259.4 33199.0 33540.7 33799.3 34131.1 35976.1 39132.4 39410.2 40033.6 40641.1 41539.0 15751.4 16028.3 16101.8 16151.4 16390.3 17189.7 17627.8 17724.9 17727.0 18089.1 16542.5 16627.0 17448.8 17511.7 18141.5 15259.7 15461.2 15536.3 16775.3 16923.6 15625.0 16466.1 16735.7 16817.9 16964.9 10538.8 10675.6 10815.4 12155.6 12280.3 13255.9 13839.7 13921.8 14180.6 14271.4 02:41:52 INFO - PID 26995 | -------- Summary: end -------- 02:41:52 INFO - PID 26995 | 02:41:53 INFO - TEST-INFO | 26995: exit 0 02:41:53 INFO - TEST-OK | dromaeo_css | took 1116024ms 02:41:53 INFO - TEST-START | kraken 02:41:53 INFO - operating with platform_type : linux_ 02:41:53 INFO - Initialising browser for kraken test... 02:41:53 INFO - TEST-INFO | started process 27327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVy0jsM/profile http://localhost:52597/getInfo.html) 02:41:57 INFO - PID 27327 | __metrics Screen width/height:1600/1200 02:41:57 INFO - PID 27327 | colorDepth:24 02:41:57 INFO - PID 27327 | Browser inner width/height: 1024/697 02:41:57 INFO - PID 27327 | __metrics 02:41:58 INFO - PID 27327 | 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" 02:41:58 INFO - PID 27327 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:41:59 INFO - TEST-INFO | 27327: exit 0 02:41:59 INFO - Browser initialized. 02:41:59 INFO - Running cycle 1/1 for kraken test... 02:41:59 INFO - TEST-INFO | started process 27427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVy0jsM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:11 INFO - PID 27427 | RSS: Main: 152899584 02:42:11 INFO - PID 27427 | 02:42:14 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52597/tests/kraken/driver.html?testName=audio-beat-detection) 02:42:15 INFO - PID 27427 | RSS: Main: 224677888 02:42:15 INFO - PID 27427 | 02:42:17 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52597/tests/kraken/driver.html?testName=audio-dft) 02:42:18 INFO - PID 27427 | RSS: Main: 186601472 02:42:18 INFO - PID 27427 | 02:42:21 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52597/tests/kraken/driver.html?testName=audio-fft) 02:42:21 INFO - PID 27427 | RSS: Main: 267509760 02:42:21 INFO - PID 27427 | 02:42:24 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52597/tests/kraken/driver.html?testName=audio-oscillator) 02:42:24 INFO - PID 27427 | RSS: Main: 178098176 02:42:24 INFO - PID 27427 | 02:42:26 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:42:27 INFO - PID 27427 | RSS: Main: 181874688 02:42:27 INFO - PID 27427 | 02:42:30 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52597/tests/kraken/driver.html?testName=imaging-darkroom) 02:42:30 INFO - PID 27427 | RSS: Main: 242126848 02:42:30 INFO - PID 27427 | 02:42:34 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52597/tests/kraken/driver.html?testName=imaging-desaturate) 02:42:34 INFO - PID 27427 | RSS: Main: 266715136 02:42:34 INFO - PID 27427 | 02:42:37 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52597/tests/kraken/driver.html?testName=json-parse-financial) 02:42:38 INFO - PID 27427 | RSS: Main: 285921280 02:42:38 INFO - PID 27427 | 02:42:39 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:42:40 INFO - PID 27427 | RSS: Main: 205807616 02:42:40 INFO - PID 27427 | 02:42:41 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52597/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:42:42 INFO - PID 27427 | RSS: Main: 210337792 02:42:42 INFO - PID 27427 | 02:42:44 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:42:45 INFO - PID 27427 | RSS: Main: 220139520 02:42:45 INFO - PID 27427 | 02:42:47 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:42:48 INFO - PID 27427 | RSS: Main: 229224448 02:42:48 INFO - PID 27427 | 02:42:51 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:42:51 INFO - PID 27427 | RSS: Main: 223653888 02:42:51 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | Cycle 1(1): loaded http://localhost:52597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52597/tests/kraken/driver.html?testName=ai-astar) 02:42:53 INFO - PID 27427 | RSS: Main: 272904192 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | __start_tp_report 02:42:53 INFO - PID 27427 | _x_x_mozilla_page_load 02:42:53 INFO - PID 27427 | _x_x_mozilla_page_load_details 02:42:53 INFO - PID 27427 | |i|pagename|runs| 02:42:53 INFO - PID 27427 | |0;ai-astar;103;108;109;109;112;109;108;111;110;109 02:42:53 INFO - PID 27427 | |1;audio-beat-detection;159;119;117;164;119;118;120;117;141;119 02:42:53 INFO - PID 27427 | |2;audio-dft;163;161;162;161;161;161;162;162;162;161 02:42:53 INFO - PID 27427 | |3;audio-fft;74;74;74;110;74;75;74;77;100;75 02:42:53 INFO - PID 27427 | |4;audio-oscillator;82;82;108;82;83;82;96;83;83;122 02:42:53 INFO - PID 27427 | |5;imaging-gaussian-blur;113;113;114;113;114;113;112;114;113;113 02:42:53 INFO - PID 27427 | |6;imaging-darkroom;147;148;147;147;146;147;146;146;147;146 02:42:53 INFO - PID 27427 | |7;imaging-desaturate;94;94;94;93;94;94;93;93;94;93 02:42:53 INFO - PID 27427 | |8;json-parse-financial;48;47;47;46;48;48;48;48;49;48 02:42:53 INFO - PID 27427 | |9;json-stringify-tinderbox;56;56;55;56;55;55;56;56;56;55 02:42:53 INFO - PID 27427 | |10;stanford-crypto-aes;83;92;82;83;83;82;84;83;90;89 02:42:53 INFO - PID 27427 | |11;stanford-crypto-ccm;127;127;137;124;121;126;123;125;178;125 02:42:53 INFO - PID 27427 | |12;stanford-crypto-pbkdf2;185;186;180;181;184;185;182;198;197;185 02:42:53 INFO - PID 27427 | |13;stanford-crypto-sha256-iterative;64;64;65;66;65;66;65;63;64;63 02:42:53 INFO - PID 27427 | __end_tp_report 02:42:53 INFO - PID 27427 | __start_cc_report 02:42:53 INFO - PID 27427 | _x_x_mozilla_cycle_collect,1702 02:42:53 INFO - PID 27427 | __end_cc_report 02:42:53 INFO - PID 27427 | __startTimestamp1492508573876__endTimestamp 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | ------- Summary: start ------- 02:42:53 INFO - PID 27427 | Number of tests: 14 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:2.39 (2.2%) stddev-sans-first:1.33 02:42:53 INFO - PID 27427 | Values: 103.0 108.0 109.0 109.0 112.0 109.0 108.0 111.0 110.0 109.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:119.50 stddev:18.43 (15.4%) stddev-sans-first:16.12 02:42:53 INFO - PID 27427 | Values: 159.0 119.0 117.0 164.0 119.0 118.0 120.0 117.0 141.0 119.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.53 02:42:53 INFO - PID 27427 | Values: 163.0 161.0 162.0 161.0 161.0 161.0 162.0 162.0 162.0 161.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#3] audio-fft Cycles:10 Average:80.70 Median:74.00 stddev:13.06 (17.6%) stddev-sans-first:13.62 02:42:53 INFO - PID 27427 | Values: 74.0 74.0 74.0 110.0 74.0 75.0 74.0 77.0 100.0 75.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.50 stddev:14.09 (17.1%) stddev-sans-first:14.62 02:42:53 INFO - PID 27427 | Values: 82.0 82.0 108.0 82.0 83.0 82.0 96.0 83.0 83.0 122.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 02:42:53 INFO - PID 27427 | Values: 113.0 113.0 114.0 113.0 114.0 113.0 112.0 114.0 113.0 113.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 02:42:53 INFO - PID 27427 | Values: 147.0 148.0 147.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:42:53 INFO - PID 27427 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 93.0 93.0 94.0 93.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#8] json-parse-financial Cycles:10 Average:47.70 Median:48.00 stddev:0.82 (1.7%) stddev-sans-first:0.87 02:42:53 INFO - PID 27427 | Values: 48.0 47.0 47.0 46.0 48.0 48.0 48.0 48.0 49.0 48.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 02:42:53 INFO - PID 27427 | Values: 56.0 56.0 55.0 56.0 55.0 55.0 56.0 56.0 56.0 55.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:83.50 stddev:3.73 (4.5%) stddev-sans-first:3.87 02:42:53 INFO - PID 27427 | Values: 83.0 92.0 82.0 83.0 83.0 82.0 84.0 83.0 90.0 89.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:126.50 stddev:16.95 (13.4%) stddev-sans-first:17.91 02:42:53 INFO - PID 27427 | Values: 127.0 127.0 137.0 124.0 121.0 126.0 123.0 125.0 178.0 125.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:185.00 stddev:6.22 (3.4%) stddev-sans-first:6.58 02:42:53 INFO - PID 27427 | Values: 185.0 186.0 180.0 181.0 184.0 185.0 182.0 198.0 197.0 185.0 02:42:53 INFO - PID 27427 | 02:42:53 INFO - PID 27427 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.08 (1.7%) stddev-sans-first:1.13 02:42:53 INFO - PID 27427 | Values: 64.0 64.0 65.0 66.0 65.0 66.0 65.0 63.0 64.0 63.0 02:42:53 INFO - PID 27427 | -------- Summary: end -------- 02:42:53 INFO - PID 27427 | 02:42:55 INFO - TEST-INFO | 27427: exit 0 02:42:55 INFO - TEST-OK | kraken | took 61738ms 02:42:55 INFO - SUITE-END | took 1177s 02:42:55 INFO - Completed test suite (00:19:38) 02:42:55 INFO - javascript benchmark 02:42:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7648.673708174587, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3260.233845046414, 3273.9686998595425, 3283.8522266498035, 3286.7041966223037, 3331.2171639664675, 5429.728513574325, 5574.191742197389, 5639.6334238274485, 5719.914201286979, 5744.16709577111, 5593.580481463896, 5652.830415087544, 5674.971625141879, 5733.913991290124, 5742.794013257221, 4879.828841078133, 4923.286123512089, 4965.056639238542, 5039.974800125994, 5091.745412729368, 5039.269305950635, 5059.6964182149, 5100.209467532539, 5109.978004399117, 5137.0, 4890.217565189588, 4942.9011419771405, 4952.257161425779, 4961.553460188564, 5034.446210916796, 4982.950170498285, 4992.6005919526715, 4998.800047998076, 5023.824166154203, 5040.193569028937, 4993.950060499385, 5002.474740152305, 5011.298418221452, 5041.899162016776, 5087.084324821531, 5639.323281206241, 5644.294463192101, 5646.294213223306, 5663.745131469093, 5692.77228910843, 5891.145783861316, 5951.4048595140575, 5955.642661440327, 6127.356627554087, 6129.325774164883, 6105.43676973216, 6159.81520554384, 6161.661108639023, 6173.783917562864, 6174.320824709278, 5707.286589176353, 5727.828165155052, 5743.052396354555, 5750.654960702372, 5751.942480575182, 6126.050462178369, 6322.178116844872, 6325.4939604832425, 6326.2724786649205, 6337.936620633827, 5929.140274660236, 5997.790077347359, 6059.121427393004, 6062.9090563641585, 6063.9090413643835, 6119.228173263922, 6163.044728067157, 6163.907541386883, 6168.814935551941, 6183.041628547582, 6092.634441933498, 6139.570230083851, 6151.108089327112, 6153.876922461615, 6158.969205154035, 5949.970250148808, 6022.728977196037, 6107.755689772448, 6123.65904821696, 6131.877362452726, 4661.347411362412, 4664.277037059262, 4666.043461090469, 4698.412698412699, 4717.764111794397, 4169.687273454503, 4172.7079104463, 4176.352665336878, 4190.287651099259, 4226.302660061117, 5551.500364967092, 5620.5503559715125, 5669.177969194444, 5730.455606717355, 5819.76720931158, 6040.939590604125, 6065.575409721366, 6088.1476593276975, 6106.126990750318, 6137.110119032715, 5625.184348269478, 5629.971850140723, 5631.267935168484, 5632.690202038927, 5637.379888212294, 5072.974635126875, 5181.5595674368105, 5188.792448302026, 5248.05535003703, 5307.150855863043, 6373.3945275198785, 6444.677766111582, 6453.064305675744, 6458.2895881453005, 6459.0, 6107.633541987495, 6129.84675383119, 6143.201383820075, 6144.324124346229, 6170.352113028068, 6112.625067133501, 6191.597546159485, 6286.52851036165, 6373.139626150411, 6373.3945275198785, 6092.939070609415, 6094.229520225711, 6096.0, 6120.724567394389, 6127.877442451215, 6121.234845644294, 6140.662263575367, 6162.4399730126315, 6187.721552530237, 6195.19462469876, 5815.331236907809, 5856.824295271149, 5873.9412605873395, 6010.729517171825, 6062.757489700539, 5894.0274854648505, 5912.46787789101, 5916.467517923407, 5918.940810591839, 5919.6152250103605, 5858.94141058584, 5869.295684517885, 5871.442212989759, 5932.2584676915385, 5976.342602313829, 6044.818655440344, 6051.1830902829315, 6052.455279024909, 6058.3335833057445, 6074.362191969956, 5863.824085277449, 5868.3251426086545, 5876.882462350643, 5879.088741245114, 5898.734556944862], "value": 5593.290273479246, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.7161991963375, 743.3532826440995, 759.8328367759093, 1129.8135807591748, 1145.9942700286497, 30949.0, 39093.413598796, 39710.81590512521, 39782.0, 39826.60173398265, 41837.16325673485, 42167.578324216745, 42220.78889605555, 42279.0, 42283.15433691324, 6062.242219722535, 6204.386859416539, 8148.022237331528, 8299.502029878196, 8304.792380190484, 8046.235607617296, 8187.5087494750205, 8214.671413143467, 8215.26062654361, 8221.260086592205, 8391.035030971425, 8483.95758021209, 8485.915140848574, 8492.0, 8497.61760720766, 8384.748457546284, 8416.789580260513, 8429.831403371898, 8430.747077587683, 8431.789205269917, 8247.092819789817, 8305.169483051706, 8316.085230624627, 8318.66725330986, 8319.376046796455, 40417.19165616671, 40618.0, 40678.79660601678, 40722.0, 40780.59219407827, 3480.3561341151967, 3508.8245587720767, 3511.7541772075965, 3521.683048525645, 3522.18989632386, 31696.207594810083, 31725.20686982821, 31788.36423271545, 31796.364072718417, 31803.84098079518, 3986.820593073319, 3992.960070399288, 3995.5005624296964, 3999.6600288975474, 4017.979910100431, 195899.0, 196731.0, 196953.99999999857, 196972.0, 197199.1400429973, 48203.0, 48405.0, 48591.757041214565, 48605.756971215626, 48610.75694621504, 50138.0, 50398.244026339635, 50745.74627126915, 50805.745971269906, 50844.0, 14138.0, 14240.074395164282, 14243.572692819233, 14244.216568088646, 14261.42954281817, 9581.089796469463, 9724.270679699051, 11031.393273369882, 11374.886251137383, 11378.544858205745, 12789.808152877715, 12959.805602915963, 13017.609471715863, 13090.410931508104, 13174.73650526984, 5129.8204562840865, 5179.700848295905, 5218.947810521922, 5221.973890130525, 5227.92158117621, 1055.8416237564272, 1106.1206340958956, 1114.4984756859446, 1132.5300000499865, 1137.647329327911, 31654.52518212229, 32057.839710801298, 32309.35381292361, 32381.838090809866, 32849.67150328466, 1161.8896204860525, 1162.5698491558178, 1164.1094562659573, 1180.6576092933126, 1200.39980009995, 13544.390502427217, 13876.306184690726, 13950.0, 14087.0, 14136.71726565463, 239274.0, 239755.0, 239822.0, 240329.0, 241012.0, 52398.47601524012, 52444.47555524396, 52531.47468525266, 52576.0, 52731.736341318814, 1406.5006922542555, 1465.4065103633045, 1480.8667219950041, 1491.4779827060659, 1499.235389951111, 23399.0, 24312.0, 24929.376765581004, 24984.375390614652, 25102.874485627453, 38641.22717545577, 38659.0, 38667.419988700756, 38671.80664096774, 38749.41875871808, 216110.0, 216812.0, 216935.0, 216961.0, 216970.0, 32822.0, 32907.341853163285, 33798.83100584481, 34288.31423371568, 34525.82737086399, 42594.57405425906, 43159.05784239779, 43195.136097278504, 43736.343954840064, 43802.49580033653, 31853.018372703413, 32025.199370015005, 32151.517727233644, 32861.0, 32942.67057329396, 31243.062708118792, 31325.686743132275, 31435.528467072556, 31706.0, 32304.83847580747, 37998.0, 37999.24001520009, 38082.809585951894, 38371.42442863415, 40304.3954340691, 31154.37691246117, 32022.0, 32356.676433235367, 33195.0, 33886.491702623985, 25428.0, 26395.472090558465, 26793.0, 26842.865785670947, 27250.727492724818], "value": 17448.16375454696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.0588998054959, 390.41827676761613, 394.81049096433713, 404.18556608434, 410.07118875746437, 14218.431262749491, 16588.585285367855, 20089.899550502247, 21950.231741889038, 21994.4501387465, 21851.453713657167, 22010.0, 22473.55052898941, 22651.320460386174, 22737.772622273773, 5692.857678558048, 5744.856378590527, 5867.501262392701, 5890.204822348992, 5904.675242861641, 3530.117470632329, 3696.242270334575, 5793.739281732311, 5910.67491287979, 5912.2018527498885, 5647.745851436695, 5842.649441033552, 5865.560082993771, 5876.030454974924, 5881.5294776417995, 5674.829755107354, 5735.541156707495, 5810.941890581083, 5876.676782776945, 5879.176915231871, 5144.536991670768, 5146.150885103953, 5148.3564554430695, 5153.56194723449, 5153.819616313449, 24444.0, 25562.87218563914, 25615.48769024609, 25678.101266455586, 25790.226293211235, 2184.8252139828774, 2208.856424332413, 2219.0, 2222.8999695013604, 2225.3101538522947, 16580.668386632322, 17390.826091739047, 17394.565135871577, 17457.301707931667, 17539.73690394645, 2253.504229069602, 2297.8621282722925, 2319.8724070176304, 2321.6981792367055, 2349.424391024193, 111224.4438777801, 117630.0, 118213.0, 119141.0, 123202.76797232003, 20063.197472100954, 20659.79340206579, 20814.895925520275, 21067.575809080266, 21287.8935605321, 38533.22933541313, 38602.42096368557, 38670.0, 39016.414753778714, 39142.0, 8086.595670216466, 8106.310963568163, 8340.207680270365, 8464.957675211708, 8578.313734901192, 7915.208479152038, 7938.650429427012, 8016.759497214976, 8142.674293028331, 8157.265846073882, 7403.815389537755, 7513.962430187923, 7538.359239464707, 7597.278258565428, 7623.733169339157, 1950.9024548772788, 1991.8705284156483, 1993.5414854583528, 2000.0799632169364, 2127.5957568062017, 1026.3636545341787, 1062.2670357453487, 1072.2147624205766, 1073.7798751255973, 1075.1506310015156, 23533.529329413315, 26359.0, 26433.867830660725, 26630.20109396721, 26753.19740407791, 1087.374759513283, 1097.6048622495896, 1097.7091070866227, 1104.2049724198564, 1126.1778901402022, 11445.0, 11987.760244795056, 12018.639440816789, 12043.518259269706, 12069.336186509827, 538731.0, 543705.0, 544858.0, 550862.0, 551091.0, 100205.49897250468, 101551.0, 101923.49038254909, 103358.48320758498, 105819.0, 1265.8354413926131, 1289.509986205236, 1291.3801375339701, 1295.520657356784, 1301.284293638495, 17961.371352002618, 18268.177931992825, 18519.166637501075, 18591.256349745858, 18648.533786655444, 49164.50835491742, 49606.27952903474, 49818.75090624524, 50166.0, 50478.0, 62562.68718656377, 62937.0, 63141.68429157825, 63788.0, 64546.35453645403, 8760.956195218983, 8801.339899507435, 9027.819443611223, 9176.35765496409, 9630.47032413224, 14828.481003164838, 15733.606659833596, 15889.761653575437, 16373.0, 16427.83572164263, 13591.728165436438, 13601.931990339985, 13698.109622874481, 13764.93117534406, 13805.0, 12493.750124997267, 12746.298953557643, 12796.232226066466, 12971.156874803108, 13448.26034568069, 13385.799213012007, 13941.442342306194, 14095.436182552583, 14147.787783183054, 14294.571162865132, 9004.774880628036, 9184.816303674022, 9196.908030919873, 9294.442333460014, 9468.384555003902, 13405.664858378228, 13895.30523473802, 13977.58067257984, 14080.647983800487, 14121.505747298796], "value": 10728.635466638862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.1626275446467, 1354.288998275905, 1402.3479082226768, 1410.8871290296777, 1419.7586410310246, 10783.299085559443, 11203.0, 11214.215004949658, 11215.327080375173, 11225.550977960882, 10811.405372704497, 10847.0, 11357.602483913064, 11397.430128493563, 11403.0, 2393.15043159678, 2427.9514409711796, 2432.8661923594195, 2434.610462326028, 2436.561418944589, 2152.268228802207, 2230.152542034025, 2236.686863839064, 2243.14760391052, 2365.7515960824126, 1918.9232430702825, 1996.670549359354, 1997.0314397517266, 1997.4906398868268, 2278.3734473019886, 2243.697100891375, 2271.716035495563, 2271.7387500437494, 2274.158561332301, 2274.624686926655, 2285.1544928376443, 2296.4488522754586, 2297.977020229793, 2315.409570559513, 2375.168690958168, 10992.0, 11100.61147859821, 11100.833487497694, 11112.16658750597, 11117.388543630097, 6303.905441418382, 6519.380658837403, 6526.608403495758, 6528.445082168021, 6531.510136739716, 3938.133610605662, 4104.220198162339, 4156.633127167004, 4195.077083041726, 4241.512226094008, 1362.9318534073257, 1374.780035194374, 1387.1469046536308, 1409.767388380916, 1441.2577522575882, 16030.919845400698, 16184.35262589495, 16212.513624591282, 16212.675746485003, 16236.0, 5083.644144909821, 5161.4322424533275, 5378.838634840961, 5396.08266594672, 5445.50990410865, 11919.284842909454, 11960.162788604714, 11961.40192990347, 11976.221545599508, 11979.005248687828, 6332.366763323631, 6333.1766870306565, 6343.27052388972, 6349.6507692077375, 6351.491880649537, 5744.396838331999, 5815.331236907809, 5853.122031695195, 5860.912086318709, 5868.559858010666, 4064.552899181088, 4147.730397524211, 4202.054537728986, 4221.704480686384, 4253.21315556623, 1208.957686480969, 1215.769003889258, 1228.2200802490304, 1233.5559198688466, 1235.7034311765112, 833.5957060825494, 852.3479538153317, 867.6225841758855, 874.0822136756508, 897.3270047464401, 6016.669083200379, 6059.303180134341, 6072.817815465543, 6147.66187859663, 6271.122042913996, 606.3814908793006, 618.038949433635, 623.8596315828993, 629.2889035390072, 629.9527535434861, 3821.7133714971487, 4216.3464662977285, 4272.46594175728, 4348.369486424451, 4416.734995900256, 13783.379747911167, 14554.563363099123, 14556.927215363856, 14575.927120364331, 14607.92696036513, 14323.928380358031, 14334.068285561405, 14363.56909292723, 14371.640708982359, 14377.065490743278, 8857.955710221408, 9265.953670231605, 9318.301127415336, 9329.953350233205, 9356.532173391302, 6244.500439964882, 6299.937000630119, 6314.589551679126, 6338.936610634019, 6456.612603243821, 12752.936235318764, 12767.80848287295, 12799.552015679406, 12920.35398230066, 13268.336583170996, 13159.0, 13260.933695331461, 13269.469221231042, 13294.867051329364, 13471.865281347453, 9144.131307525775, 9319.906800931903, 9323.393979391589, 9327.81344373095, 9410.38832475887, 10357.689269321932, 10390.688279351632, 10439.58241670355, 10440.63457778974, 10444.373337599769, 8506.362022848434, 8686.739397818075, 8758.343124265833, 8758.430702004349, 8934.910650893407, 8190.262876341158, 8283.213094755989, 8303.501789892625, 8318.334533237448, 8329.250367466957, 7283.708651653875, 7388.704451821867, 7390.408767298496, 7399.741009064657, 7405.925940740523, 5528.0, 5555.194496798023, 5613.101903695389, 5682.488576028178, 5730.255066841284, 5346.647475110939, 5405.621606487508, 5429.701366424727, 5519.586031047767, 5564.610477266552], "value": 5129.697328362902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.19390117346535, 386.21020014071206, 386.341288103783, 387.79640688638443, 388.3921662598034, 5562.499375056244, 5689.562141529603, 5821.301443826741, 5838.532917366606, 5857.589968702187, 5579.191017302489, 5664.640486283293, 5677.9716101419535, 5690.374058853523, 5730.971345143279, 4408.603225709678, 4411.867643970686, 4416.315471101984, 4424.601785839274, 4424.712393694415, 4154.854580089697, 4284.614384705376, 4290.6352959998285, 4416.293393057112, 4427.800748966288, 4264.104538047014, 4298.161858437606, 4304.504981927072, 4307.547707490716, 4314.417553630251, 4298.011457364808, 4302.870913872589, 4305.483341998949, 4305.870823875289, 4315.4821421429315, 3763.172102137525, 3766.152615661482, 3769.5288088988877, 3776.4901738265257, 3844.942325865114, 5541.778328866841, 5559.9444005559835, 5573.554115670737, 5638.026690658277, 5642.238297829782, 5227.503387178212, 5249.658772179796, 5252.480837838657, 5260.710660913648, 5270.0, 5949.286085669704, 6035.849103772441, 6103.314541601681, 6132.0, 6143.569950103494, 4445.799939002753, 4462.12988467249, 4467.597916187527, 4468.50846406895, 4469.955300446986, 6415.518836087312, 6429.678516074225, 6458.806235812933, 6469.32072132424, 6501.6749162542155, 4385.583369579885, 4515.796789144496, 4518.728876267369, 4519.502854685982, 4560.110778398247, 4582.770861456914, 4590.163934426256, 4591.668416159343, 4603.95396046042, 4609.746463944448, 5215.947840521622, 5216.4522725114075, 5216.556592689588, 5228.55557277628, 5237.633365664443, 5860.3260625027815, 5871.2073870027, 6065.211522502046, 6117.204763380732, 6171.444569988723, 1512.3648067811546, 1561.5315405378342, 1595.6728870581503, 1602.262959038832, 1603.0862408427317, 1080.7298175456135, 1112.5772206561455, 1117.5753213778873, 1118.4351902289293, 1122.5341483284508, 5781.364049954502, 5803.881583222178, 5833.766649333979, 5839.941600583939, 5867.178594996704, 6160.260768707783, 6193.81418557444, 6232.594881332699, 6238.313785483593, 6286.748530058838, 5633.070543360382, 5851.473367396955, 5873.530117590582, 5894.204282421904, 5901.645901245939, 3295.703386695161, 3332.250243695149, 3333.449980753197, 3337.6495467975997, 3351.379994700988, 6271.6550589718, 6400.55196136266, 6444.387783160592, 6491.610503369813, 6508.837279068061, 6381.266154392304, 6404.871902561923, 6412.262589802139, 6418.1656384669695, 6458.644774537352, 6234.350401079614, 6446.065320528497, 6468.3855033771715, 6483.003222019613, 6504.121943537656, 6247.750089996349, 6284.811455656338, 6287.654179020014, 6304.3380445054445, 6311.116443697978, 6256.530760192913, 6265.874682506415, 6271.560990730787, 6290.685465726604, 6312.715927783169, 6327.147388665558, 6487.643179625166, 6506.316836732264, 6528.249251336157, 6534.248561415308, 4309.116631090682, 4315.8489452869, 4317.568243175658, 4324.502682191588, 4341.088371442032, 5908.1137829324225, 5915.585908986502, 6336.493080553452, 6344.0, 6362.6818659067785, 6061.39386061408, 6102.481289090477, 6104.4505994460715, 6114.419130182626, 6138.693065346625, 6074.635521868702, 6093.756249750138, 6152.538559608137, 6163.7842675506145, 6165.84585385369, 5885.499732522783, 6034.577579569388, 6091.451769340781, 6096.29892562361, 6098.695065246631, 6073.817785466443, 6095.1466794647895, 6108.328083910677, 6119.877602448015, 6139.263288405241, 5755.7409916553015, 5904.881902361843, 5967.9701601491715, 5968.701564921824, 5975.40245975399], "value": 4643.769198832885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.9720811167554, 867.5662168915542, 876.3077169036461, 882.1178821178821, 883.2271762208068, 13250.66873328166, 16079.276432560533, 16918.40785572505, 16937.0, 17021.31914723411, 16781.580460488465, 17388.82611173888, 17449.214785334658, 17580.736288955675, 17601.55996100098, 981.4700061966547, 1023.4575674892319, 1027.4503140819663, 1028.4754775064735, 1028.6399760083987, 734.2657342657343, 1040.069138121381, 1043.0247718383298, 1043.8799538053106, 1044.7335929338008, 802.2178376083331, 1026.6714651311584, 1053.3627155570884, 1058.4125810175349, 1059.9629012984547, 1029.402946291157, 1039.365986748087, 1039.7140786283758, 1040.3861721584265, 1041.167066346927, 556.2129586634907, 764.6176911544228, 764.6826566974698, 764.7055883484843, 765.0857225615392, 12923.935380323132, 16691.41580044705, 17366.305347786074, 17426.0, 17466.126693665392, 17915.0, 18687.0, 18740.625187496174, 18813.15340809667, 18901.243950241973, 14874.0, 15094.773578396223, 15096.0, 15131.470398536108, 15135.318910649048, 3574.267275208576, 3620.818959052037, 3625.0393645683916, 3629.038304849217, 3630.981845090784, 86521.56739216327, 88101.55949220277, 90318.0, 91052.0, 91192.54403728005, 11385.829212561819, 15071.623209419633, 15463.149526775911, 15598.454054108051, 15633.374665013273, 19481.805181948283, 25878.22365329043, 25881.870590646926, 25962.740372596032, 26814.463710726068, 8523.318134549221, 8679.913200868037, 8694.304455643532, 8700.608472618747, 8716.346274029473, 4221.113566151143, 4310.245707001262, 4311.267084595626, 4351.08627188294, 4412.889677758082, 4285.335772955197, 4343.913121737548, 4350.086481838849, 4366.6506679465565, 4370.912581748347, 886.7339798060556, 893.3835653399134, 901.1664210605164, 903.8960519540205, 904.2178515584104, 635.3265538529174, 650.0801366067057, 653.3531803514581, 662.1689779326914, 663.6648492511348, 10763.569457221623, 11096.722581935515, 11521.423928803526, 11784.764304713857, 11869.762604747857, 604.8880957022965, 605.6668832142392, 607.7660100861112, 614.9508039356841, 620.4725982914576, 5144.742762861842, 5211.609129315317, 5419.3225846769155, 5479.123340265538, 5480.177973304037, 74128.0, 75586.24413755901, 76189.23810761822, 76199.0, 76601.0, 66858.66570667212, 68521.0, 68715.0, 68786.65606671934, 69850.3014969854, 61241.693791531645, 62050.0692489604, 62112.378876210656, 62262.68868655628, 63200.683996579726, 11268.0, 12176.507147296457, 12195.146339756131, 12206.633800985985, 12259.448324825225, 33199.0, 33540.66459335375, 33799.3240135191, 34131.14672133117, 35976.10059748423, 39132.413013804246, 39410.211795764495, 40033.599664002984, 40641.13909178623, 41539.0, 15751.369945202521, 16028.27872745706, 16101.75847362267, 16151.434699785452, 16390.344386224417, 17189.656206876043, 17627.82372176262, 17724.91137544304, 17727.0, 18089.095545222423, 16542.503724888273, 16627.0, 17448.82551174472, 17511.737323939895, 18141.546461338574, 15259.694806104038, 15461.226938652797, 15536.30086646081, 16775.328986840388, 16923.57691057684, 15625.0, 16466.09436481005, 16735.748963765796, 16817.915910420368, 16964.915175424045, 10538.789224215627, 10675.626353077605, 10815.405152716676, 12155.599603567889, 12280.32458214771, 13255.933720331337, 13839.723205536035, 13921.79117313221, 14180.645483862985, 14271.357788899732], "value": 8027.09215919471, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 108.0, 109.0, 109.0, 112.0, 109.0, 108.0, 111.0, 110.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 119.0, 117.0, 164.0, 119.0, 118.0, 120.0, 117.0, 141.0, 119.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 110.0, 74.0, 75.0, 74.0, 77.0, 100.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 108.0, 82.0, 83.0, 82.0, 96.0, 83.0, 83.0, 122.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 112.0, 114.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 47.0, 46.0, 48.0, 48.0, 48.0, 48.0, 49.0, 48.0], "value": 47.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 92.0, 82.0, 83.0, 83.0, 82.0, 84.0, 83.0, 90.0, 89.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 137.0, 124.0, 121.0, 126.0, 123.0, 125.0, 178.0, 125.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 180.0, 181.0, 184.0, 185.0, 182.0, 198.0, 197.0, 185.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 65.0, 66.0, 65.0, 63.0, 64.0, 63.0], "value": 64.5, "unit": "score"}]}]} 02:42:55 INFO - Return code: 0 02:42:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:42:55 ERROR - # TBPL SUCCESS # 02:42:55 INFO - Running post-action listener: _resource_record_post_action 02:42:55 INFO - [mozharness: 2017-04-18 09:42:55.708929Z] Finished run-tests step (success) 02:42:55 INFO - Running post-run listener: _resource_record_post_run 02:42:55 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 369147904; Read time: 104; Write time: 254484 02:42:55 INFO - TinderboxPrint: CPU usage
12.9% 02:42:55 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 104 02:42:55 INFO - TinderboxPrint: I/O write bytes / time
369,147,904 / 254,484 02:42:55 INFO - TinderboxPrint: CPU idle
8,298.0 (87.1%) 02:42:55 INFO - TinderboxPrint: CPU user
1,185.3 (12.4%) 02:42:55 INFO - TinderboxPrint: Swap in / out
0 / 0 02:42:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115683328; Read time: 0; Write time: 110996 02:42:55 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253464576; Read time: 88; Write time: 143488 02:42:56 INFO - Running post-run listener: _upload_blobber_files 02:42:56 INFO - Blob upload gear active. 02:42:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:42:56 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 02:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:42:56 INFO - (blobuploader) - INFO - Open directory for files ... 02:42:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:42:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:42:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:58 INFO - (blobuploader) - INFO - Done attempting. 02:42:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:42:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:42:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:58 INFO - (blobuploader) - INFO - Done attempting. 02:42:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:42:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:42:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:59 INFO - (blobuploader) - INFO - Done attempting. 02:42:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:42:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:43:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:02 INFO - (blobuploader) - INFO - Done attempting. 02:43:02 INFO - (blobuploader) - INFO - Iteration through files over. 02:43:02 INFO - Return code: 0 02:43:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:43:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:43:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62c6bc10a83fdf48a957f807f1aefa874c700b59651c7a92e062da6abd387a12c9fa9189838097226bbf58f0ea72d420299544228de4ee57cf42e798a2180ad4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7500d7d70388c4188722dbda63503d4ec03500ff49123376b3894a5ab15ff99e4db888c4451186d11016f7b9aa1d1ecc2679fa0f39721d69821e9e22302bfe60", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ad18fa77ccafd8d32b9fdfe7e6fc2606639c4a6797d3062687d7266bf79102cd2e0556b34bdc44913a96f558e240eedf2a8f058b905a527f689732fa9279e73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e75511ccc6a52881a74979c435727a7043865ac57fc0aa5552a6b4aa624fa88bc5a3c48f4a3924f451a6d2e4b91b5ea4ead006e7e04acb8950b9c4b8bd3f91d8"} 02:43:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:43:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:43:02 INFO - Contents: 02:43:02 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62c6bc10a83fdf48a957f807f1aefa874c700b59651c7a92e062da6abd387a12c9fa9189838097226bbf58f0ea72d420299544228de4ee57cf42e798a2180ad4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7500d7d70388c4188722dbda63503d4ec03500ff49123376b3894a5ab15ff99e4db888c4451186d11016f7b9aa1d1ecc2679fa0f39721d69821e9e22302bfe60", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ad18fa77ccafd8d32b9fdfe7e6fc2606639c4a6797d3062687d7266bf79102cd2e0556b34bdc44913a96f558e240eedf2a8f058b905a527f689732fa9279e73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e75511ccc6a52881a74979c435727a7043865ac57fc0aa5552a6b4aa624fa88bc5a3c48f4a3924f451a6d2e4b91b5ea4ead006e7e04acb8950b9c4b8bd3f91d8"} 02:43:02 INFO - Running post-run listener: copy_logs_to_upload_dir 02:43:02 INFO - Copying logs to upload dir... 02:43:02 INFO - mkdir: /builds/slave/test/build/upload/logs 02:43:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.633886 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-18 02:43:02.624034) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 02:43:02.627438) ========= 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=14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62c6bc10a83fdf48a957f807f1aefa874c700b59651c7a92e062da6abd387a12c9fa9189838097226bbf58f0ea72d420299544228de4ee57cf42e798a2180ad4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7500d7d70388c4188722dbda63503d4ec03500ff49123376b3894a5ab15ff99e4db888c4451186d11016f7b9aa1d1ecc2679fa0f39721d69821e9e22302bfe60", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ad18fa77ccafd8d32b9fdfe7e6fc2606639c4a6797d3062687d7266bf79102cd2e0556b34bdc44913a96f558e240eedf2a8f058b905a527f689732fa9279e73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e75511ccc6a52881a74979c435727a7043865ac57fc0aa5552a6b4aa624fa88bc5a3c48f4a3924f451a6d2e4b91b5ea4ead006e7e04acb8950b9c4b8bd3f91d8"} build_url:https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011515 build_url: 'https://queue.taskcluster.net/v1/task/NNoH2L9PSmiGYcvMu4i_GQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62c6bc10a83fdf48a957f807f1aefa874c700b59651c7a92e062da6abd387a12c9fa9189838097226bbf58f0ea72d420299544228de4ee57cf42e798a2180ad4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7500d7d70388c4188722dbda63503d4ec03500ff49123376b3894a5ab15ff99e4db888c4451186d11016f7b9aa1d1ecc2679fa0f39721d69821e9e22302bfe60", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ad18fa77ccafd8d32b9fdfe7e6fc2606639c4a6797d3062687d7266bf79102cd2e0556b34bdc44913a96f558e240eedf2a8f058b905a527f689732fa9279e73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e75511ccc6a52881a74979c435727a7043865ac57fc0aa5552a6b4aa624fa88bc5a3c48f4a3924f451a6d2e4b91b5ea4ead006e7e04acb8950b9c4b8bd3f91d8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 02:43:02.652680) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:43:02.652990) ========= 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=14ef55db36f7623abb31b9cf000001d5-1492507326.50524-569657382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:43:02.735872) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 02:43:02.736212) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 02:43:02.736499) ========= ========= Total master_lag: 0.17 =========