builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1483542200.57 results: success (0) revision: c8b77ff3986597028c3ea39f42109289b8bf0e56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:20.571219) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:20.571721) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:20.572007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:20.586538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:20.586802) ========= 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-1483541456.970436-1370129953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-04 07:03:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.2M=0s 2017-01-04 07:03:20 (24.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134064 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:20.734044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:20.734359) ========= 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-1483541456.970436-1370129953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019131 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:20.783796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:20.784094) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c8b77ff3986597028c3ea39f42109289b8bf0e56 --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 c8b77ff3986597028c3ea39f42109289b8bf0e56 --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-1483541456.970436-1370129953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-04 07:03:21,077 truncating revision to first 12 chars 2017-01-04 07:03:21,077 Setting DEBUG logging. 2017-01-04 07:03:21,077 attempt 1/10 2017-01-04 07:03:21,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c8b77ff39865?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 07:03:21,377 unpacking tar archive at: mozilla-central-c8b77ff39865/testing/mozharness/ program finished with exit code 0 elapsedTime=0.593252 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:21.390564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:21.390889) ========= script_repo_revision: c8b77ff3986597028c3ea39f42109289b8bf0e56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:21.391280) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:21.391567) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:21.399743) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-04 07:03:21.400018) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:03:21 INFO - MultiFileLogger online at 20170104 07:03:21 in /builds/slave/test 07:03:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:03:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:03:21 INFO - {'append_to_log': False, 07:03:21 INFO - 'base_work_dir': '/builds/slave/test', 07:03:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:03:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:03:21 INFO - 'branch': 'Firefox-Non-PGO', 07:03:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:03:21 INFO - 'config_files': ('talos/linux_config.py',), 07:03:21 INFO - 'default_actions': ('clobber', 07:03:21 INFO - 'read-buildbot-config', 07:03:21 INFO - 'download-and-extract', 07:03:21 INFO - 'populate-webroot', 07:03:21 INFO - 'create-virtualenv', 07:03:21 INFO - 'install', 07:03:21 INFO - 'run-tests'), 07:03:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:03:21 INFO - 'download_minidump_stackwalk': True, 07:03:21 INFO - 'download_symbols': 'ondemand', 07:03:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:03:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:03:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:03:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:03:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:03:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:03:21 INFO - 'installer_path': 'installer.exe', 07:03:21 INFO - 'log_level': 'info', 07:03:21 INFO - 'log_name': 'talos', 07:03:21 INFO - 'log_to_console': True, 07:03:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:03:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:03:21 INFO - 'opt_config_files': (), 07:03:21 INFO - 'pip_index': False, 07:03:21 INFO - 'sps_profile': False, 07:03:21 INFO - 'sps_profile_interval': 0, 07:03:21 INFO - 'suite': 'dromaeojs', 07:03:21 INFO - 'system_bits': '32', 07:03:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:03:21 INFO - 'title': 'talos-linux64-ix-036', 07:03:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:03:21 INFO - 'use_talos_json': True, 07:03:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:03:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:03:21 INFO - 'work_dir': 'build'} 07:03:21 INFO - [mozharness: 2017-01-04 15:03:21.789067Z] Running clobber step. 07:03:21 INFO - Running pre-action listener: _resource_record_pre_action 07:03:21 INFO - Running main action method: clobber 07:03:21 INFO - rmtree: /builds/slave/test/build 07:03:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:03:22 INFO - Running post-action listener: _resource_record_post_action 07:03:22 INFO - [mozharness: 2017-01-04 15:03:22.256169Z] Finished clobber step (success) 07:03:22 INFO - [mozharness: 2017-01-04 15:03:22.256271Z] Running read-buildbot-config step. 07:03:22 INFO - Running pre-action listener: _resource_record_pre_action 07:03:22 INFO - Running main action method: read_buildbot_config 07:03:22 INFO - Using buildbot properties: 07:03:22 INFO - { 07:03:22 INFO - "project": "", 07:03:22 INFO - "product": "firefox", 07:03:22 INFO - "who": "ffxbld@noreply.mozilla.org", 07:03:22 INFO - "installer_path": "public/build/target.tar.bz2", 07:03:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:03:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:03:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:03:22 INFO - "stage_platform": "linux64", 07:03:22 INFO - "basedir": "/builds/slave/test", 07:03:22 INFO - "buildnumber": 369, 07:03:22 INFO - "platform": "ubuntu64_hw", 07:03:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:03:22 INFO - "slavebuilddir": "test", 07:03:22 INFO - "taskId": "f6zKAVs9SCioE1CzE2jSBA", 07:03:22 INFO - "branch": "mozilla-central", 07:03:22 INFO - "script_repo_revision": "production", 07:03:22 INFO - "revision": "c8b77ff3986597028c3ea39f42109289b8bf0e56", 07:03:22 INFO - "slavename": "talos-linux64-ix-036", 07:03:22 INFO - "repo_path": "mozilla-central" 07:03:22 INFO - } 07:03:22 INFO - Finding installer, test and symbols from parent task. 07:03:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f6zKAVs9SCioE1CzE2jSBA'}, attempt #1 07:03:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f6zKAVs9SCioE1CzE2jSBA'}, attempt #1 07:03:23 INFO - Task dependencies: SgwOvsZVSeuLniXBIdkpwQ 07:03:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ'}, attempt #1 07:03:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 07:03:23 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/test_packages.json 07:03:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.crashreporter-symbols.zip 07:03:23 INFO - Running post-action listener: _resource_record_post_action 07:03:23 INFO - [mozharness: 2017-01-04 15:03:23.651584Z] Finished read-buildbot-config step (success) 07:03:23 INFO - [mozharness: 2017-01-04 15:03:23.651802Z] Running download-and-extract step. 07:03:23 INFO - Running pre-action listener: _resource_record_pre_action 07:03:23 INFO - Running main action method: download_and_extract 07:03:23 INFO - mkdir: /builds/slave/test/build/tests 07:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:23 INFO - trying https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.test_packages.json 07:03:23 INFO - Downloading https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:03:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:03:24 INFO - Downloaded 896 bytes. 07:03:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:03:24 INFO - Using the following test package requirements: 07:03:24 INFO - {u'common': [u'target.common.tests.zip'], 07:03:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:03:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:03:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:03:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:03:24 INFO - u'mozbase': [u'target.common.tests.zip'], 07:03:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:03:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:03:24 INFO - u'web-platform': [u'target.common.tests.zip', 07:03:24 INFO - u'target.web-platform.tests.zip'], 07:03:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:03:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:03:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip 07:03:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:03:24 INFO - Fetch https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip into memory 07:03:25 INFO - Expected file size: 20247084 07:03:25 INFO - Obtained file size: 20247084 07:03:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:03:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip 07:03:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:03:28 INFO - Fetch https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip into memory 07:03:29 INFO - Expected file size: 20247084 07:03:29 INFO - Obtained file size: 20247084 07:03:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.talos.tests.zip 07:03:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:03:34 INFO - Fetch https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.talos.tests.zip into memory 07:03:35 INFO - Expected file size: 14403730 07:03:35 INFO - Obtained file size: 14403730 07:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:35 INFO - trying https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 07:03:35 INFO - Downloading https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:03:36 INFO - Downloaded 55917614 bytes. 07:03:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 07:03:36 INFO - mkdir: /builds/slave/test/properties 07:03:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:03:36 INFO - Writing to file /builds/slave/test/properties/build_url 07:03:36 INFO - Contents: 07:03:36 INFO - build_url:https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 07:03:36 INFO - Running post-action listener: _resource_record_post_action 07:03:36 INFO - Running post-action listener: set_extra_try_arguments 07:03:36 INFO - [mozharness: 2017-01-04 15:03:36.415402Z] Finished download-and-extract step (success) 07:03:36 INFO - [mozharness: 2017-01-04 15:03:36.415498Z] Running populate-webroot step. 07:03:36 INFO - Running pre-action listener: _resource_record_pre_action 07:03:36 INFO - Running main action method: populate_webroot 07:03:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:03:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:03:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:03:36 INFO - '--tppagecycles', 07:03:36 INFO - '7'], 07:03:36 INFO - 'tests': ['tsvgm']}}, 07:03:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:03:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:03:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:03:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:03:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:03:36 INFO - 'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:03:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:03:36 INFO - 'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['damp', 'tps']}, 07:03:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:03:36 INFO - 'tests': ['damp', 'tps']}, 07:03:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['dromaeo_dom']}, 07:03:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:03:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['basic_compositor_video']}, 07:03:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:03:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['a11yr', 07:03:36 INFO - 'ts_paint', 07:03:36 INFO - 'tpaint', 07:03:36 INFO - 'sessionrestore', 07:03:36 INFO - 'sessionrestore_no_auto_restore', 07:03:36 INFO - 'tabpaint']}, 07:03:36 INFO - 'other-e10s': {'tests': ['a11yr', 07:03:36 INFO - 'ts_paint', 07:03:36 INFO - 'tpaint', 07:03:36 INFO - 'sessionrestore', 07:03:36 INFO - 'sessionrestore_no_auto_restore', 07:03:36 INFO - 'tabpaint']}, 07:03:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:03:36 INFO - 'ts_paint', 07:03:36 INFO - 'tpaint', 07:03:36 INFO - 'sessionrestore', 07:03:36 INFO - 'sessionrestore_no_auto_restore', 07:03:36 INFO - 'tabpaint']}, 07:03:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:03:36 INFO - 'ts_paint', 07:03:36 INFO - 'tpaint', 07:03:36 INFO - 'sessionrestore', 07:03:36 INFO - 'sessionrestore_no_auto_restore', 07:03:36 INFO - 'tabpaint']}, 07:03:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['a11yr', 07:03:36 INFO - 'ts_paint', 07:03:36 INFO - 'tpaint', 07:03:36 INFO - 'sessionrestore', 07:03:36 INFO - 'sessionrestore_no_auto_restore', 07:03:36 INFO - 'tabpaint']}, 07:03:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['a11yr', 07:03:36 INFO - 'ts_paint', 07:03:36 INFO - 'tpaint', 07:03:36 INFO - 'sessionrestore', 07:03:36 INFO - 'sessionrestore_no_auto_restore', 07:03:36 INFO - 'tabpaint']}, 07:03:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['tsvgx', 07:03:36 INFO - 'tsvgr_opacity', 07:03:36 INFO - 'tart', 07:03:36 INFO - 'tscrollx', 07:03:36 INFO - 'cart', 07:03:36 INFO - 'tsvg_static']}, 07:03:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:03:36 INFO - 'tsvgr_opacity', 07:03:36 INFO - 'tart', 07:03:36 INFO - 'tscrollx', 07:03:36 INFO - 'cart', 07:03:36 INFO - 'tsvg_static']}, 07:03:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:03:36 INFO - 'talos_options': ['--disable-e10s'], 07:03:36 INFO - 'tests': ['tp5o']}, 07:03:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:03:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:03:36 INFO - 'talos_options': ['--disable-e10s', 07:03:36 INFO - '--xperf_path', 07:03:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:36 INFO - 'tests': ['tp5n']}, 07:03:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:03:36 INFO - 'talos_options': ['--xperf_path', 07:03:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:36 INFO - 'tests': ['tp5n']}}, 07:03:36 INFO - 'talos.zip': {'path': '', 07:03:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:03:36 INFO - Running post-action listener: _resource_record_post_action 07:03:36 INFO - [mozharness: 2017-01-04 15:03:36.428472Z] Finished populate-webroot step (success) 07:03:36 INFO - [mozharness: 2017-01-04 15:03:36.428561Z] Running create-virtualenv step. 07:03:36 INFO - Running pre-action listener: _resource_record_pre_action 07:03:36 INFO - Running main action method: create_virtualenv 07:03:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:03:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:03:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:03:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:03:36 INFO - Using real prefix '/usr' 07:03:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:03:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:03:38 INFO - Installing pip.................done. 07:03:38 INFO - Return code: 0 07:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:03:39 INFO - Reading from file tmpfile_stdout 07:03:39 INFO - Output received: 07:03:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:03:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:39 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 0x28ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, '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-1483541456.970436-1370129953', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:03:39 INFO - Using env: {'DISPLAY': ':0', 07:03:39 INFO - 'HOME': '/home/cltbld', 07:03:39 INFO - 'LANG': 'en_US.UTF-8', 07:03:39 INFO - 'LANGUAGE': 'en_US:en', 07:03:39 INFO - 'LOGNAME': 'cltbld', 07:03:39 INFO - 'MAIL': '/var/mail/cltbld', 07:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:39 INFO - 'MOZ_NO_REMOTE': '1', 07:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:39 INFO - 'NO_EM_RESTART': '1', 07:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:39 INFO - 'PWD': '/builds/slave/test', 07:03:39 INFO - 'SHELL': '/bin/bash', 07:03:39 INFO - 'SHLVL': '1', 07:03:39 INFO - 'TERM': 'linux', 07:03:39 INFO - 'TMOUT': '86400', 07:03:39 INFO - 'USER': 'cltbld', 07:03:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:39 INFO - '_': '/tools/buildbot/bin/python'} 07:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:03:39 INFO - Cleaning up... 07:03:39 INFO - Return code: 0 07:03:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:39 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 0x28ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, '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-1483541456.970436-1370129953', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:03:39 INFO - Using env: {'DISPLAY': ':0', 07:03:39 INFO - 'HOME': '/home/cltbld', 07:03:39 INFO - 'LANG': 'en_US.UTF-8', 07:03:39 INFO - 'LANGUAGE': 'en_US:en', 07:03:39 INFO - 'LOGNAME': 'cltbld', 07:03:39 INFO - 'MAIL': '/var/mail/cltbld', 07:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:39 INFO - 'MOZ_NO_REMOTE': '1', 07:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:39 INFO - 'NO_EM_RESTART': '1', 07:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:39 INFO - 'PWD': '/builds/slave/test', 07:03:39 INFO - 'SHELL': '/bin/bash', 07:03:39 INFO - 'SHLVL': '1', 07:03:39 INFO - 'TERM': 'linux', 07:03:39 INFO - 'TMOUT': '86400', 07:03:39 INFO - 'USER': 'cltbld', 07:03:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:39 INFO - '_': '/tools/buildbot/bin/python'} 07:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:39 INFO - Downloading/unpacking psutil>=3.1.1 07:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:03:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:03:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:03:41 INFO - Installing collected packages: psutil 07:03:41 INFO - Running setup.py install for psutil 07:03:41 INFO - building 'psutil._psutil_linux' extension 07:03:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:03:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:03:41 INFO - building 'psutil._psutil_posix' extension 07:03:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:03:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:03:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:03:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:03:42 INFO - Successfully installed psutil 07:03:42 INFO - Cleaning up... 07:03:42 INFO - Return code: 0 07:03:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:42 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 0x28ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, '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-1483541456.970436-1370129953', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:03:42 INFO - Using env: {'DISPLAY': ':0', 07:03:42 INFO - 'HOME': '/home/cltbld', 07:03:42 INFO - 'LANG': 'en_US.UTF-8', 07:03:42 INFO - 'LANGUAGE': 'en_US:en', 07:03:42 INFO - 'LOGNAME': 'cltbld', 07:03:42 INFO - 'MAIL': '/var/mail/cltbld', 07:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:42 INFO - 'MOZ_NO_REMOTE': '1', 07:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:42 INFO - 'NO_EM_RESTART': '1', 07:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:42 INFO - 'PWD': '/builds/slave/test', 07:03:42 INFO - 'SHELL': '/bin/bash', 07:03:42 INFO - 'SHLVL': '1', 07:03:42 INFO - 'TERM': 'linux', 07:03:42 INFO - 'TMOUT': '86400', 07:03:42 INFO - 'USER': 'cltbld', 07:03:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:42 INFO - '_': '/tools/buildbot/bin/python'} 07:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:03:44 INFO - Installing collected packages: mozsystemmonitor 07:03:44 INFO - Running setup.py install for mozsystemmonitor 07:03:44 INFO - Successfully installed mozsystemmonitor 07:03:44 INFO - Cleaning up... 07:03:44 INFO - Return code: 0 07:03:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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', '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 0x28ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, '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-1483541456.970436-1370129953', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:03: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 jsonschema==2.5.1 07:03:44 INFO - Using env: {'DISPLAY': ':0', 07:03:44 INFO - 'HOME': '/home/cltbld', 07:03:44 INFO - 'LANG': 'en_US.UTF-8', 07:03:44 INFO - 'LANGUAGE': 'en_US:en', 07:03:44 INFO - 'LOGNAME': 'cltbld', 07:03:44 INFO - 'MAIL': '/var/mail/cltbld', 07:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:44 INFO - 'MOZ_NO_REMOTE': '1', 07:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:44 INFO - 'NO_EM_RESTART': '1', 07:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:44 INFO - 'PWD': '/builds/slave/test', 07:03:44 INFO - 'SHELL': '/bin/bash', 07:03:44 INFO - 'SHLVL': '1', 07:03:44 INFO - 'TERM': 'linux', 07:03:44 INFO - 'TMOUT': '86400', 07:03:44 INFO - 'USER': 'cltbld', 07:03:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:44 INFO - '_': '/tools/buildbot/bin/python'} 07:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:03:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03:47 INFO - Downloading functools32-3.2.3-2.tar.gz 07:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:03:47 INFO - warning: no files found matching '*.txt' 07:03:47 INFO - no previously-included directories found matching 'build' 07:03:47 INFO - no previously-included directories found matching 'dist' 07:03:47 INFO - no previously-included directories found matching '.git*' 07:03:47 INFO - Installing collected packages: jsonschema, functools32 07:03:47 INFO - Running setup.py install for functools32 07:03:47 INFO - warning: no files found matching '*.txt' 07:03:47 INFO - no previously-included directories found matching 'build' 07:03:47 INFO - no previously-included directories found matching 'dist' 07:03:47 INFO - no previously-included directories found matching '.git*' 07:03:47 INFO - Successfully installed jsonschema functools32 07:03:47 INFO - Cleaning up... 07:03:47 INFO - Return code: 0 07:03:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:47 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 0x28ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, '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-1483541456.970436-1370129953', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:03:47 INFO - Using env: {'DISPLAY': ':0', 07:03:47 INFO - 'HOME': '/home/cltbld', 07:03:47 INFO - 'LANG': 'en_US.UTF-8', 07:03:47 INFO - 'LANGUAGE': 'en_US:en', 07:03:47 INFO - 'LOGNAME': 'cltbld', 07:03:47 INFO - 'MAIL': '/var/mail/cltbld', 07:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:47 INFO - 'MOZ_NO_REMOTE': '1', 07:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:47 INFO - 'NO_EM_RESTART': '1', 07:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:47 INFO - 'PWD': '/builds/slave/test', 07:03:47 INFO - 'SHELL': '/bin/bash', 07:03:47 INFO - 'SHLVL': '1', 07:03:47 INFO - 'TERM': 'linux', 07:03:47 INFO - 'TMOUT': '86400', 07:03:47 INFO - 'USER': 'cltbld', 07:03:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:47 INFO - '_': '/tools/buildbot/bin/python'} 07:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:03:47 INFO - Cleaning up... 07:03:47 INFO - Return code: 0 07:03:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:47 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 0x28ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, '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-1483541456.970436-1370129953', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:03:47 INFO - Using env: {'DISPLAY': ':0', 07:03:47 INFO - 'HOME': '/home/cltbld', 07:03:47 INFO - 'LANG': 'en_US.UTF-8', 07:03:47 INFO - 'LANGUAGE': 'en_US:en', 07:03:47 INFO - 'LOGNAME': 'cltbld', 07:03:47 INFO - 'MAIL': '/var/mail/cltbld', 07:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:47 INFO - 'MOZ_NO_REMOTE': '1', 07:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:47 INFO - 'NO_EM_RESTART': '1', 07:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:47 INFO - 'PWD': '/builds/slave/test', 07:03:47 INFO - 'SHELL': '/bin/bash', 07:03:47 INFO - 'SHLVL': '1', 07:03:47 INFO - 'TERM': 'linux', 07:03:47 INFO - 'TMOUT': '86400', 07:03:47 INFO - 'USER': 'cltbld', 07:03:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:47 INFO - '_': '/tools/buildbot/bin/python'} 07:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:03:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:03:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:50 INFO - Downloading docopt-0.6.1.tar.gz 07:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:03:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:03:50 INFO - Running setup.py install for blobuploader 07:03:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:03:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:03:50 INFO - Running setup.py install for requests 07:03:51 INFO - Running setup.py install for docopt 07:03:51 INFO - Successfully installed blobuploader requests docopt 07:03:51 INFO - Cleaning up... 07:03:51 INFO - Return code: 0 07:03:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:51 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 0x28ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, '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-1483541456.970436-1370129953', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:03:51 INFO - Using env: {'DISPLAY': ':0', 07:03:51 INFO - 'HOME': '/home/cltbld', 07:03:51 INFO - 'LANG': 'en_US.UTF-8', 07:03:51 INFO - 'LANGUAGE': 'en_US:en', 07:03:51 INFO - 'LOGNAME': 'cltbld', 07:03:51 INFO - 'MAIL': '/var/mail/cltbld', 07:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:51 INFO - 'MOZ_NO_REMOTE': '1', 07:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:51 INFO - 'NO_EM_RESTART': '1', 07:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:51 INFO - 'PWD': '/builds/slave/test', 07:03:51 INFO - 'SHELL': '/bin/bash', 07:03:51 INFO - 'SHLVL': '1', 07:03:51 INFO - 'TERM': 'linux', 07:03:51 INFO - 'TMOUT': '86400', 07:03:51 INFO - 'USER': 'cltbld', 07:03:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:51 INFO - '_': '/tools/buildbot/bin/python'} 07:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:03:51 INFO - Running setup.py (path:/tmp/pip-Oh6sTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:03:51 INFO - Running setup.py (path:/tmp/pip-cLs2xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:51 INFO - Running setup.py (path:/tmp/pip-ylAS9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:51 INFO - Running setup.py (path:/tmp/pip-xdkxd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:51 INFO - Running setup.py (path:/tmp/pip-61tdeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:51 INFO - Running setup.py (path:/tmp/pip-4t50wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:51 INFO - Running setup.py (path:/tmp/pip-8p6MNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:52 INFO - Running setup.py (path:/tmp/pip-7f3n4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:52 INFO - Running setup.py (path:/tmp/pip-MQVqif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:52 INFO - Running setup.py (path:/tmp/pip-eLGLQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:52 INFO - Running setup.py (path:/tmp/pip-wOIs9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:52 INFO - Running setup.py (path:/tmp/pip-La9xeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:52 INFO - Running setup.py (path:/tmp/pip-Tg44X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:52 INFO - Running setup.py (path:/tmp/pip-LH1Eve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:52 INFO - Running setup.py (path:/tmp/pip-BoXruZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:52 INFO - Running setup.py (path:/tmp/pip-2enPId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:52 INFO - Running setup.py (path:/tmp/pip-MN7c98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:03:52 INFO - Running setup.py install for manifestparser 07:03:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:03:52 INFO - Running setup.py install for mozcrash 07:03:52 INFO - Running setup.py install for mozdebug 07:03:53 INFO - Running setup.py install for mozdevice 07:03:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:03:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:03:53 INFO - Running setup.py install for mozfile 07:03:53 INFO - Running setup.py install for mozhttpd 07:03:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:03:53 INFO - Running setup.py install for mozinfo 07:03:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:03:53 INFO - Running setup.py install for mozInstall 07:03:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:03:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:03:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:03:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:03:53 INFO - Running setup.py install for mozleak 07:03:53 INFO - Running setup.py install for mozlog 07:03:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:03:53 INFO - Running setup.py install for moznetwork 07:03:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:03:53 INFO - Running setup.py install for mozprocess 07:03:53 INFO - Running setup.py install for mozprofile 07:03:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:03:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:03:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:03:54 INFO - Running setup.py install for mozrunner 07:03:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:03:54 INFO - Running setup.py install for mozscreenshot 07:03:54 INFO - Running setup.py install for moztest 07:03:54 INFO - Running setup.py install for mozversion 07:03:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:03:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:03:54 INFO - Cleaning up... 07:03:54 INFO - Return code: 0 07:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:54 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 0x28ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, '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-1483541456.970436-1370129953', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:03:54 INFO - Using env: {'DISPLAY': ':0', 07:03:54 INFO - 'HOME': '/home/cltbld', 07:03:54 INFO - 'LANG': 'en_US.UTF-8', 07:03:54 INFO - 'LANGUAGE': 'en_US:en', 07:03:54 INFO - 'LOGNAME': 'cltbld', 07:03:54 INFO - 'MAIL': '/var/mail/cltbld', 07:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:54 INFO - 'MOZ_NO_REMOTE': '1', 07:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:54 INFO - 'NO_EM_RESTART': '1', 07:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:54 INFO - 'PWD': '/builds/slave/test', 07:03:54 INFO - 'SHELL': '/bin/bash', 07:03:54 INFO - 'SHLVL': '1', 07:03:54 INFO - 'TERM': 'linux', 07:03:54 INFO - 'TMOUT': '86400', 07:03:54 INFO - 'USER': 'cltbld', 07:03:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:54 INFO - '_': '/tools/buildbot/bin/python'} 07:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:03:54 INFO - Running setup.py (path:/tmp/pip-MyDmCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:03:54 INFO - Running setup.py (path:/tmp/pip-M1Nmnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:54 INFO - Running setup.py (path:/tmp/pip-EACc_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:54 INFO - Running setup.py (path:/tmp/pip-XSVEWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:55 INFO - Running setup.py (path:/tmp/pip-8A8x0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:55 INFO - Running setup.py (path:/tmp/pip-gnAPvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:55 INFO - Running setup.py (path:/tmp/pip-5wC_Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:55 INFO - Running setup.py (path:/tmp/pip-dUd3bZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:55 INFO - Running setup.py (path:/tmp/pip-7qEdVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:55 INFO - Running setup.py (path:/tmp/pip-unuD8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:55 INFO - Running setup.py (path:/tmp/pip-Z7b5I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:55 INFO - Running setup.py (path:/tmp/pip-7BAyRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:55 INFO - Running setup.py (path:/tmp/pip-kitlJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:55 INFO - Running setup.py (path:/tmp/pip-G0tIpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:55 INFO - Running setup.py (path:/tmp/pip-kXndoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:55 INFO - Running setup.py (path:/tmp/pip-kfOboh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:55 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)) 07:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:55 INFO - Running setup.py (path:/tmp/pip-8z7BNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:03:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:58 INFO - Downloading blessings-1.6.tar.gz 07:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:03:58 INFO - Installing collected packages: blessings 07:03:58 INFO - Running setup.py install for blessings 07:03:58 INFO - Successfully installed blessings 07:03:58 INFO - Cleaning up... 07:03:58 INFO - Return code: 0 07:03:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:58 INFO - Reading from file tmpfile_stdout 07:03:58 INFO - Current package versions: 07:03:58 INFO - argparse == 1.2.1 07:03:58 INFO - blessings == 1.6 07:03:58 INFO - blobuploader == 1.2.4 07:03:58 INFO - docopt == 0.6.1 07:03:58 INFO - functools32 == 3.2.3-2 07:03:58 INFO - jsonschema == 2.5.1 07:03:58 INFO - manifestparser == 1.1 07:03:58 INFO - mozInstall == 1.12 07:03:58 INFO - mozcrash == 1.0 07:03:58 INFO - mozdebug == 0.1 07:03:58 INFO - mozdevice == 0.49 07:03:58 INFO - mozfile == 1.2 07:03:58 INFO - mozhttpd == 0.7 07:03:58 INFO - mozinfo == 0.9 07:03:58 INFO - mozleak == 0.1 07:03:58 INFO - mozlog == 3.4 07:03:58 INFO - moznetwork == 0.27 07:03:58 INFO - mozprocess == 0.23 07:03:58 INFO - mozprofile == 0.28 07:03:58 INFO - mozrunner == 6.13 07:03:58 INFO - mozscreenshot == 0.1 07:03:58 INFO - mozsystemmonitor == 0.3 07:03:58 INFO - moztest == 0.8 07:03:58 INFO - mozversion == 1.4 07:03:58 INFO - psutil == 3.1.1 07:03:58 INFO - requests == 1.2.3 07:03:58 INFO - wsgiref == 0.1.2 07:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:58 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 0x28ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, '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-1483541456.970436-1370129953', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:03:58 INFO - Using env: {'DISPLAY': ':0', 07:03:58 INFO - 'HOME': '/home/cltbld', 07:03:58 INFO - 'LANG': 'en_US.UTF-8', 07:03:58 INFO - 'LANGUAGE': 'en_US:en', 07:03:58 INFO - 'LOGNAME': 'cltbld', 07:03:58 INFO - 'MAIL': '/var/mail/cltbld', 07:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:58 INFO - 'MOZ_NO_REMOTE': '1', 07:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:58 INFO - 'NO_EM_RESTART': '1', 07:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:58 INFO - 'PWD': '/builds/slave/test', 07:03:58 INFO - 'SHELL': '/bin/bash', 07:03:58 INFO - 'SHLVL': '1', 07:03:58 INFO - 'TERM': 'linux', 07:03:58 INFO - 'TMOUT': '86400', 07:03:58 INFO - 'USER': 'cltbld', 07:03:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:58 INFO - '_': '/tools/buildbot/bin/python'} 07:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:03:58 INFO - Cleaning up... 07:03:58 INFO - Return code: 0 07:03:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, '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-1483541456.970436-1370129953', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:03:58 INFO - Using env: {'DISPLAY': ':0', 07:03:58 INFO - 'HOME': '/home/cltbld', 07:03:58 INFO - 'LANG': 'en_US.UTF-8', 07:03:58 INFO - 'LANGUAGE': 'en_US:en', 07:03:58 INFO - 'LOGNAME': 'cltbld', 07:03:58 INFO - 'MAIL': '/var/mail/cltbld', 07:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:58 INFO - 'MOZ_NO_REMOTE': '1', 07:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:58 INFO - 'NO_EM_RESTART': '1', 07:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:58 INFO - 'PWD': '/builds/slave/test', 07:03:58 INFO - 'SHELL': '/bin/bash', 07:03:58 INFO - 'SHLVL': '1', 07:03:58 INFO - 'TERM': 'linux', 07:03:58 INFO - 'TMOUT': '86400', 07:03:58 INFO - 'USER': 'cltbld', 07:03:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:58 INFO - '_': '/tools/buildbot/bin/python'} 07:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:03:58 INFO - Cleaning up... 07:03:58 INFO - Return code: 0 07:03:58 INFO - Running post-action listener: _resource_record_post_action 07:03:58 INFO - Running post-action listener: _start_resource_monitoring 07:03:58 INFO - Starting resource monitoring. 07:03:58 INFO - [mozharness: 2017-01-04 15:03:58.982511Z] Finished create-virtualenv step (success) 07:03:58 INFO - [mozharness: 2017-01-04 15:03:58.983012Z] Running install step. 07:03:58 INFO - Running pre-action listener: _resource_record_pre_action 07:03:58 INFO - Running main action method: install 07:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:59 INFO - Reading from file tmpfile_stdout 07:03:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:03:59 INFO - Reading from file tmpfile_stdout 07:03:59 INFO - Output received: 07:03:59 INFO - Usage: mozinstall [options] installer 07:03:59 INFO - Options: 07:03:59 INFO - -h, --help show this help message and exit 07:03:59 INFO - -d DEST, --destination=DEST 07:03:59 INFO - Directory to install application into. [default: 07:03:59 INFO - "/builds/slave/test"] 07:03:59 INFO - --app=APP Application being installed. [default: firefox] 07:03:59 INFO - mkdir: /builds/slave/test/build/application 07:03:59 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'] 07:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:04:15 INFO - Reading from file tmpfile_stdout 07:04:15 INFO - Output received: 07:04:15 INFO - /builds/slave/test/build/application/firefox/firefox 07:04:15 INFO - Running post-action listener: _resource_record_post_action 07:04:15 INFO - [mozharness: 2017-01-04 15:04:15.932830Z] Finished install step (success) 07:04:15 INFO - [mozharness: 2017-01-04 15:04:15.932954Z] Running run-tests step. 07:04:15 INFO - Running pre-action listener: _resource_record_pre_action 07:04:15 INFO - Running main action method: run_tests 07:04:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:04:15 INFO - Python 2.7.3 07:04:15 INFO - Return code: 0 07:04:15 INFO - grabbing minidump binary from tooltool 07:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:15 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 0x2cb5850>, '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 0x2c2a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2ab60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:04:15 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 07:04:15 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 07:04:15 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 07:04:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:04:16 INFO - Return code: 0 07:04:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:04:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:04:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:04:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:04:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:04:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/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 07:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/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 07:04:16 INFO - Using env: {'DISPLAY': ':0', 07:04:16 INFO - 'HOME': '/home/cltbld', 07:04:16 INFO - 'LANG': 'en_US.UTF-8', 07:04:16 INFO - 'LANGUAGE': 'en_US:en', 07:04:16 INFO - 'LOGNAME': 'cltbld', 07:04:16 INFO - 'MAIL': '/var/mail/cltbld', 07:04:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:16 INFO - 'MOZ_NO_REMOTE': '1', 07:04:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:16 INFO - 'NO_EM_RESTART': '1', 07:04:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:16 INFO - 'PWD': '/builds/slave/test', 07:04:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:16 INFO - 'SHELL': '/bin/bash', 07:04:16 INFO - 'SHLVL': '1', 07:04:16 INFO - 'TERM': 'linux', 07:04:16 INFO - 'TMOUT': '86400', 07:04:16 INFO - 'USER': 'cltbld', 07:04:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483541456.970436-1370129953', 07:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:16 INFO - '_': '/tools/buildbot/bin/python'} 07:04:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/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 07:04:16 INFO - mozversion application_buildid: 20170104143437 07:04:16 INFO - mozversion application_changeset: c8b77ff3986597028c3ea39f42109289b8bf0e56 07:04:16 INFO - mozversion application_display_name: Nightly 07:04:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:04:16 INFO - mozversion application_name: Firefox 07:04:16 INFO - mozversion application_remotingname: firefox 07:04:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:04:16 INFO - mozversion application_vendor: Mozilla 07:04:16 INFO - mozversion application_version: 53.0a1 07:04:16 INFO - mozversion platform_buildid: 20170104143437 07:04:16 INFO - mozversion platform_changeset: c8b77ff3986597028c3ea39f42109289b8bf0e56 07:04:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:04:16 INFO - mozversion platform_version: 53.0a1 07:04:16 INFO - using testdate: 1483542256 07:04:16 INFO - actual date: 1483542256 07:04:16 INFO - starting webserver on 'localhost:52415' 07:04:16 INFO - SUITE-START | Running 2 tests 07:04:16 INFO - TEST-START | dromaeo_css 07:04:16 INFO - operating with platform_type : linux_ 07:04:16 INFO - Initialising browser for dromaeo_css test... 07:04:16 INFO - TEST-INFO | started process 18131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJ6g5b/profile http://localhost:52415/getInfo.html) 07:04:16 INFO - PROCESS | 18131 | 1483542256737 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4901 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3756 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2789 < callProvider()@resource://gre/modules/AddonManager.jsm:260 < _startProvider()@resource://gre/modules/AddonManager.jsm:755 < startup()@resource://gre/modules/AddonManager.jsm:937 < startup()@resource://gre/modules/AddonManager.jsm:2886 < observe()@resource://gre/components/addonManager.js:65 07:04:20 INFO - PROCESS | 18131 | __metrics Screen width/height:1600/1200 07:04:20 INFO - PROCESS | 18131 | colorDepth:24 07:04:20 INFO - PROCESS | 18131 | Browser inner width/height: 1024/697 07:04:20 INFO - PROCESS | 18131 | __metrics 07:04:20 INFO - PROCESS | 18131 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:04:20 INFO - PROCESS | 18131 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:04:21 INFO - PROCESS | 18131 | console.error: PushService: 07:04:21 INFO - PROCESS | 18131 | stateChangeProcessEnqueue: Error transitioning state 07:04:21 INFO - PROCESS | 18131 | UnknownError 07:04:22 INFO - TEST-INFO | 18131: exit 0 07:04:22 INFO - Browser initialized. 07:04:22 INFO - Running cycle 1/1 for dromaeo_css test... 07:04:22 INFO - TEST-INFO | started process 18214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJ6g5b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:34 INFO - PROCESS | 18214 | RSS: Main: 151449600 07:04:34 INFO - PROCESS | 18214 | 07:05:26 INFO - PROCESS | 18214 | 1483542326130 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:07:38 INFO - PROCESS | 18214 | Cycle 1(1): loaded http://localhost:52415/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52415/tests/dromaeo/cssquery-ext.html) 07:07:40 INFO - PROCESS | 18214 | RSS: Main: 272633856 07:07:40 INFO - PROCESS | 18214 | 07:09:23 INFO - PROCESS | 18214 | ************************* 07:09:23 INFO - PROCESS | 18214 | A coding exception was thrown and uncaught in a Task. 07:09:23 INFO - PROCESS | 18214 | 07:09:23 INFO - PROCESS | 18214 | Full message: ReferenceError: fetch is not defined 07:09:23 INFO - PROCESS | 18214 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:09:23 INFO - PROCESS | 18214 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:09:23 INFO - PROCESS | 18214 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:09:23 INFO - PROCESS | 18214 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:09:23 INFO - PROCESS | 18214 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:09:23 INFO - PROCESS | 18214 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:09:23 INFO - PROCESS | 18214 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:09:23 INFO - PROCESS | 18214 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:09:23 INFO - PROCESS | 18214 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:09:23 INFO - PROCESS | 18214 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:09:23 INFO - PROCESS | 18214 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:09:23 INFO - PROCESS | 18214 | 07:09:23 INFO - PROCESS | 18214 | ************************* 07:10:43 INFO - PROCESS | 18214 | Cycle 1(1): loaded http://localhost:52415/tests/dromaeo/cssquery-ext.html (next: http://localhost:52415/tests/dromaeo/cssquery-jquery.html) 07:10:43 INFO - PROCESS | 18214 | RSS: Main: 244666368 07:10:43 INFO - PROCESS | 18214 | 07:13:46 INFO - PROCESS | 18214 | Cycle 1(1): loaded http://localhost:52415/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52415/tests/dromaeo/cssquery-mootools.html) 07:13:46 INFO - PROCESS | 18214 | RSS: Main: 184496128 07:13:46 INFO - PROCESS | 18214 | 07:16:48 INFO - PROCESS | 18214 | Cycle 1(1): loaded http://localhost:52415/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52415/tests/dromaeo/cssquery-prototype.html) 07:16:49 INFO - PROCESS | 18214 | RSS: Main: 194564096 07:16:49 INFO - PROCESS | 18214 | 07:19:52 INFO - PROCESS | 18214 | Cycle 1(1): loaded http://localhost:52415/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52415/tests/dromaeo/cssquery-yui.html) 07:19:53 INFO - PROCESS | 18214 | RSS: Main: 184307712 07:19:53 INFO - PROCESS | 18214 | 07:22:56 INFO - PROCESS | 18214 | Cycle 1(1): loaded http://localhost:52415/tests/dromaeo/cssquery-yui.html (next: http://localhost:52415/tests/dromaeo/cssquery-dojo.html) 07:22:56 INFO - PROCESS | 18214 | RSS: Main: 270061568 07:22:56 INFO - PROCESS | 18214 | 07:22:56 INFO - PROCESS | 18214 | __start_tp_report 07:22:56 INFO - PROCESS | 18214 | _x_x_mozilla_page_load 07:22:56 INFO - PROCESS | 18214 | _x_x_mozilla_page_load_details 07:22:56 INFO - PROCESS | 18214 | |i|pagename|runs| 07:22:56 INFO - PROCESS | 18214 | |0;dojo.html;2545.465452255027;2571.2286314105763;2594.1309661263476;2600.089968511021;2601.336659151917;4519.096180763844;4587.2889702096145;4689.648276379268;4729.527047295273;4746.525347465256;4589.609883159927;4595.03504264105;4604.4014278143795;4633.791479383427;4663.417072865892;4269.530351661315;4305.160493703729;4339.392485052095;4370.147821174872;4449.199144154051;3952.7733246273506;4268.231718290706;4387.0129220925355;4406.206882761102;4457.621102206316;4172.666186705056;4197.307444271692;4203.033302340448;4285.764282964436;4313.4176886120285;4229.0273237155625;4231.322988321854;4236.04688944988;4236.364545318196;4237.025484138635;4269.573042695737;4313.805878735465;4331.523532411432;4367.301231802896;4380.956190438087;4640.767961601907;4694.835680751192;4723.031778485402;4769;4771.522847715235;5057.595392368602;5064.063148317537;5066.847994560169;5069.239614057921;5114.872128196787;4885.804567817283;4917.164082106051;4930.137225985438;5044.722540260284;5089.134847076006;4736.786844592001;4759.571638552477;4761.571458568746;4802.47172810994;4805.8558243252755;5186.222066690027;5192.4547922468355;5194.35070616173;5201.3238279024245;5244.344456942882;4801.51984801517;4845.6608037437045;4947.675518515211;4979.950200498021;5004.749762511859;4976.552110310089;4982;4982.252662100714;4984.576311013532;5026.321446604735;5023.949760502422;5049;5051.621128415383;5055.368078990126;5106.131957567222;5038.2190760432195;5044.419891712427;5048.798048078109;5051.393832740095;5097.235414687752;4101.651359634465;4126.339785634284;4253.064325848309;4256.3828244904935;4305.784710764449;3666.046827824785;3676.963230367662;3694.3165514379925;3728.4034554471154;3733.7386382953478;4365.388845561624;4368.4321038264825;4375.321825117112;4379.189849877783;4420.9336859947125;5047.722375269395;5088.847334579968;5092.6180536459915;5097.362829646294;5141.485851414904;4195.958040419557;4214.388913607571;4331.6534677225745;4353.69524133314;4368.213721530155;4585.701929374647;4586.945002649342;4600.378948841931;4626.699264547794;4626.791794369262;4743.715377077387;4745.881352966204;4747.477777444409;4750.762461876961;4800.903981920412;4901.877453063559;4932.4327702314695;5094.490550944876;5095.133827249302;5134;4732.858014259577;4770.475247722818;4779.641526885428;4780.282957556395;4825.782839772289;4805.879853003703;4842.273658951185;4844.128056949783;5020.171671674133;5027.522385373383;5021.748912554431;5049.2173713074535;5061.7469126544265;5074.517920797666;5081.7713202905215;4776.522347765195;4815.590674792682;4931.432885218246;4936.234883593049;4941.604671626189;4859.149648811514;4861.902761944671;4863.805447782049;4864.075825593268;4867.90264194707;4778.04439112172;4793.304970779148;4798.7840547174765;4800.543948324904;4840.709557426566;4954.628402869727;5010.473900240422;5018.071656743514;5049.545540901337;5060.3168572242275;4877.341558889504;4889.364382630235;4893.266010098514;4893.7063776173545;4936.2102063669645 07:22:56 INFO - PROCESS | 18214 | |1;ext.html;531.9095753721867;563.5181919458862;570.463764061782;586.4371450085522;592.1532208941218;35540;39457.210855782905;39477.40783888244;39502.20995580087;39570.8021459893;39065.41401878974;39467.80266098666;39595.802020989926;39643.00892477683;39675;7594.620268986556;7719.112302085262;7789.454738168331;7900.683972641087;7903.40724445666;10066.24503162262;10370.429626370547;10373.170146388271;10721.249512534127;10734.463276836166;10282.845757313646;10341.224408169379;10354.482275886214;10371.48142592871;10387.792244155113;10240.590376384936;10260.794784104351;10286.897131028669;10307.175425965905;10309.793804123912;10207.13239374654;10262.281640285182;10274.434906080163;10279.074883260542;10284.537195826131;39315.60684393177;39673.404898926536;39700.80149599262;39722.602773972176;39748;3557.3596752584526;3692.2061756722433;3708.35103856824;3739.2708421857747;3774.1885494618787;29392;29650.25874353137;29767.10698679043;30994.535081973787;31193.84403077993;3472.2187507810795;3558.5018097466377;3571.3035957988204;3582.4805403216387;3724.1620635356826;242132;243042;243378;243639;245674;56122;56606.716966415726;56696;56728.43271567314;56774.148387774214;58812;59053.818923621286;59100.70449647724;59174.40825591689;59191.70404147952;14678.119312841263;15150.772738408932;15165.620859478602;15166.772498412533;15167.317470713844;10598.364098154136;10810.513526891309;10831.67504974852;11135.944320278346;11323.886761132448;16170.514884553482;17526.298948041935;17734.46796596104;17829.375971840924;18368.357107501175;6071.544634152457;6290.24517057956;6330.556861019684;6343.968280158662;6397.584157029778;745.1877453575629;753.9736109236151;758.135725273189;779.2713812585251;781.3202513813019;27327.316817079336;28481.715182848322;28497.857510712314;28806.85596572004;28991.710082898902;949.4967667136428;967.1778987860263;970.2868391732071;983.1446641422009;999.2355847776457;14646.633834154018;15084.698306033817;15302.416538622792;15354.462593809163;15490.845091549165;343902;346229;346303;346461;346698;51260.74369628128;51333.99999999925;51462.22806657903;51510;51530.48469515332;1207.2575366149754;1245.5017992802589;1257.0258050011314;1258.069028918612;1258.144461766008;25195.370115747253;26720.19839404821;27042.45915081648;27398.72601273962;27483.862580686968;43555;44098.33852492151;44128.77935610301;44154.33768493411;44165;287172;287694;287960;289320;289852;37372.62627373692;37846;37976.81011594924;38190.80904595459;38245;39572.802135989135;39703.40444893387;39787.2042559153;39858.402123967586;40475.1904961905;34395.796147135734;34723.30553388969;34926.47610285797;35238.295234094665;35481;34795.47806782951;34954.47568286528;35273.294534109686;35286.823565882005;35344.82327588346;33405.83297083499;34089.318213635095;34754.78358257449;34846;35065;29548.852255738584;31209.219769505034;31286.217844554067;31771.20571985719;31955.201119972186;23806.523869522858;24199.395015124763;24281.709005312616;24478.63282050735;24548.38629034217 07:22:56 INFO - PROCESS | 18214 | |2;jquery.html;337.9814110223937;338.7459405445914;351.7484998226268;355.22560817418025;375.8308761057523;12740.617781466559;15639.374425023;16407.17964101796;16419.91790041048;17604.735928961076;16978.49064528063;17132.31470741169;17164.485065448025;17199.82800171998;17561.56096097598;4179.101493178966;4955.157623204055;5131.2303154526935;5132.486751324875;5144.6913185209005;5025.04524140414;5034.295198672189;5034.42104158021;5069.44236134025;5082.313887625179;5016.3980322361185;5021.422536408305;5028.522290382408;5036.169032109698;5038.59691224703;5213.165893457048;5278.366596008465;5290.418054014055;5290.57675385972;5292.020976119411;4984.77568509418;5107.693538387672;5140.049090918192;5140.434552199293;5141.948580514184;19538.609227815505;19845.106970186233;19846.603067938562;21729.67405488919;22267.109315627356;2263.1400067974228;2277.9658305125436;2392.4018995251186;2454.2023842251338;2591.3521619595103;13066.673333166651;14048.681967475355;14527.20100394478;14648.487302944346;14911.254437278092;1834.5413646588354;1873.8219869112413;1884.689026310657;1889.763779527559;1928.1227041695995;76543.99999999945;77817;79430;79858.20141798566;80791;17463.21415536304;17712.46862594124;17768.200430980636;17885.195166217552;17885.7317140243;30721.846390767903;30733.078007659806;30735.385292294475;30829.383412331626;31210.375792484025;8715.91284087151;8855.38012339143;9017.188453039258;9076.31927605419;9266.193092347063;7281.577658500496;7291.927080729125;7308.451866110063;7448.702051917862;7485.513441626277;8645.394822362374;8982.371234013686;9115.225205857443;9139.908600913906;9256.72229833106;3537.398642230827;3719.9814000929823;3752.887413377603;3785.545734511876;3904.531456225271;788.9526628402314;808.7452452477569;809.5830647216688;810.3841080778533;831.3141658132065;14639.707205855822;14884.916111744364;14968.17675027862;15160.924195378953;15467.922660386626;758.6737702787855;772;800.6597196191595;807.5477732469835;810.5177419435427;8259;8413.655619237477;8919.777005574782;9049.665354036028;9087;339728;349849;353319;353754;354171;52622.47377526252;57283;73298.26701733022;74860;75762.62118689371;855.5096734725062;877.6138499060393;895.2256298301922;896.6906417286026;898.4070513461215;13749.456350575176;13772.793408098687;13828.93085534566;13865.51470698561;14276.21480818565;32458.675413245564;34092.65907340994;34320.82839585786;34706.652933470345;35918.28163436664;38270.234595308495;48078;48838.26742598793;49008.2648760276;49386.506134938194;7108.147022357351;7155;7312.5246858954;7406.111266648037;7467.514611550232;9869.506524673881;11277.154213433862;11386;11540;11884.940575297069;9917.256205784739;10066.547005384922;10092.747681308027;10397.220208484243;10449.373037617766;9433.764155896157;9474.242060634995;9664.513378316038;10303.484825758833;10632.681019569425;9832.360896541702;9978.351407158512;10036.698899033041;10249.38503689751;10303.175745940156;7329;7451.105867295959;7481.663325150273;7752.302292793675;7793.012162533449;9171.587278572346;10058.380320343413;10061.144802691853;10168.186545076229;10471 07:22:56 INFO - PROCESS | 18214 | |3;mootools.html;1333.3466601365328;1338.9665258368539;1345.0382976172034;1348.3190988550787;1350.7568637645227;6673.366030227126;6963.303669633035;6966.16406031277;6971.09375781149;6976.965115174424;6073.240844894388;6250.718717657705;6641.302663220365;6806.081179040828;6907.30926907309;1905.3617038292155;1927.8650494465394;1932.0726051495292;1933.0528041259752;1934.032983508246;2007.42788305333;2069.068918986462;2073.2639912830955;2088.467440802601;2097.0772859941576;1798.7841459024935;1854.7310639957198;2003.378952524722;2048.6926960955825;2054.075665950321;2060.1965233559;2061.051916118587;2069.4412508622736;2071.4200023993308;2081.1467298407733;1951.6877299632133;1967.3212741604123;1971.418431562678;1972.4970132616234;1978.5350442645968;6815.693293801791;6968.44252459802;7091.25541818112;7101;7107.360337569644;4142.71001029928;4259.8509052183335;4268.253055715238;4278.893027674302;4285.442892423996;2642.735726427361;2728.1679087878188;2791.665000199989;2792.3298408381843;2800.2159395369126;952.3857112162616;996.5764550066193;1034.8344264917653;1035.554711474066;1690.2478397113289;8778.385513014091;8898.644054237888;8920.821583568293;8938.419002764864;8941.552922353922;3571.3571557119967;3766.39737641976;3787.7348585598743;3793.1275806564645;3801.657850793442;7306.159791624032;7315.158756742936;7325.450591205575;7331.816704582428;7333.88999165013;4209.17921005401;4209.5790420957655;4209.663226941837;4212.620864122244;4216.409702641633;3799.696024318048;3892.4355968384994;3904.590018048064;3905.6094390560716;3906.7851268180525;2988.835614041205;3007.804492707967;3068.861901214451;3082.321889184376;3085.167004908662;897.5512243878061;906.4606559097458;913.3058875254854;925.1026504290827;926.346925417579;848.3849209323315;868.9826203475895;874.3573473496974;896.9955150224207;902.0933961368913;4839.153148199051;5028.748562571856;5030.37120359955;5178.689278643294;5205.947940520547;900.5722281916037;924.2605915267759;925.0980294213089;939.4081728510994;973.4500007495742;3257.218267615755;3401.2857299967286;3461.2385275239913;3474.0967348489576;3493.3013397320638;8134.26791588748;8325.292350150185;8400.873986890201;8407.53758543286;8432.494050356998;8195.139510351446;8224;8367.539785311745;8374.036985746596;8383.455075420079;6443.5167362448;6635.668216589248;6635.834104147435;6637.435817955431;6653.068570400148;4702.48272689997;4797.64017698681;4810.735409552368;4840.346553215411;4857.635677324285;7425.925740742523;7509.136449308399;7531.209223031503;7537.886931695919;7538.547687138789;7537.54774713519;7734.690612375442;7776.650050747843;7779.260970207822;7786.571738554434;5521.3926468087675;5690.487856092972;5736.770529178786;5742.598018138858;5757.107648314518;6568.638724870178;6643.501737369813;6645.269020407654;6647.734090636321;6649.368310010541;5829.650220986754;5946.791862284799;5976.372480889618;5985.191999080069;6070.575059745952;5770.163326317745;5779.162021506774;5825.417458254141;5838.4453476919625;5860.150278209721;5383.757730902197;5466.863328416822;5468.808591699271;5475.178723191394;5476.835694929158;4028.5165780105403;4030.294698427822;4051.4530538376944;4161.916761664689;4226;3951.7431366962205;4038.7980600969245;4051.108756073659;4074.083331250445;4106.856260030884 07:22:56 INFO - PROCESS | 18214 | |4;prototype.html;303.92857678445546;318.5365293497959;324.654243230959;331.4746127388089;331.5308837994238;4655.4878963314;4781.330613714083;4900.730459824713;4901.093297739921;4918.827841025565;4589.793459294331;4823.324734537167;4830.160022781888;4834.63740219484;4835.5097124980575;3736.794476303809;3737.1030952571323;3750.474933509311;3755.2114056048126;3772.3775577029755;3613.765105268162;3640.5813331466825;3688.391415416453;3744.6629803317696;3756.624337566249;3678.1907980244305;3680.7791532508;3692.3722967095523;3696.2607478504274;3716.2753263113705;3679.22736225393;3680.3743363628246;3685.5761587417387;3699;3700.518932538753;3083.290843106076;3118.7972781769113;3173.984130079358;3187.3943950649536;3228.677132286776;4714.528547145293;4717.882052948669;4736.621070314367;4737.9813340131695;4753.928691069636;4127.649149822269;4193.287141186006;4198.160367926396;4215.978920105411;4228.513720922103;4809.615230781529;5015.974920125376;5073;5088.23676448532;5089.949100509021;3518.577770667511;3525.506429099928;3525.6121826599056;3529.400001999666;3542.1321776164746;5288.805145864461;5307.548858347045;5321.707306098163;5322.600804939645;5325.121354976385;3615.439606860941;3625;3636.2182130841998;3641.5448068990845;3643.398839191557;3559.2703495783303;3612.6387361263664;3644.9635503645154;3655.8354874030733;3659.908502287411;4049.7367671101283;4120.649744771668;4142.813573389205;4202.915941681149;4210.5578914214175;5029.798808047711;5061.44324124346;5072.289879416885;5077.213031980049;5079.74601269935;1221.9755604887853;1232.6055662188194;1236.6537369536545;1237.1772771107112;1245.4768997021272;830.2693629605908;831.4055450353027;837.3050368194506;844.2190973349627;852.1733918099434;4353.477582690098;4354.738715677069;4362.541933096979;4369.978150109229;4388.451443569554;5080.872978175576;5086.338775959101;5088.669236499616;5091.7963281469065;5109.514596113363;4220.8895552223885;4360.345948107746;4390.473143222834;4392.604665580113;4393.231184542692;2630.473905218964;2649.827761195516;2652.005497938273;2696.474187533412;2696.7864460992632;4661.533846615312;4679.181143299909;4710.175719249118;4759.405074365704;4781.824269957161;5019.268352418409;5189.6886186828915;5209.348831396075;5213.168321283853;5239.711815850089;4723;4742.786574604151;4744.8849520362;4747.762611869462;4750.548697873696;5076.314697515936;5091;5094.872628184176;5104.336436263262;5105.259737337991;4777.331173635764;4984.501549844987;4998.350214472095;5000;5004.224345226496;4719.268513380432;4722.480527141943;4726.952730472652;4750.738709371018;4752.738599376929;3547.7693949893173;3552.431610942237;3569.268299998546;3571.9642803571633;3576.374134526395;4874.26963427978;5076.340075790271;5097.209932460474;5105.2342148678;5110.48895110486;4931.827386041471;4938.654294199515;4940.382452193476;4947.975260123821;4959.082569724468;4950.905683947532;4980.990302806131;4983.775730092227;5020.623453240948;5024.773885175249;4751.61987041029;4916.934887347251;4919.680220785637;4928.827491037797;4939;5093.261477085876;5097.7706003229205;5098.490150984871;5107.770150343169;5110.872228194325;4967.627427942991;4969.950300496948;4972.428170760409;4981.4769449207315;5003.849884503471 07:22:56 INFO - PROCESS | 18214 | |5;yui.html;661.546840414316;684.3327755438448;729.8430837369964;753.2994315286783;765.5598031132099;12814.423350949206;13575.796363054538;13594.320283985786;13653.726925461497;13686.657833554165;11905.761884762322;11989.760204795899;12001.51993920242;12010.45952932118;12013.399330033508;669.6819010969799;677.529117263502;784.8587254294225;791.9089304729972;811.1563973467587;805.5166899860067;834.5701963488777;834.8330333933208;835.419383528448;836.0928392693935;868.8783570300163;868.9131086891324;868.9608967596441;869.4783130121939;869.5565261716507;693.2097408953797;699.059764616595;820.0937963550251;865.3034307382586;865.312076898867;620.2928661326092;627.7143899525705;629.298332359416;629.3329071184513;629.7418058595954;13112.541061062817;13124.606261812161;13155.736885262337;13171.60485185446;13181.802272965913;13110.27893465859;13128.803067953988;13142.605721828264;13156;13209.86790132096;11794.764104717857;11874.228175168586;11878.287302761775;12069.517219311305;12137.696557586043;4033.6168064034164;4039.9596004040172;4070.1859628074208;4118.19695159444;4129.421880936671;61092;61516.38483615151;63737.36262637361;64365;64931;10159.644412445678;10415.68752937413;10458.895411045944;10506.264561480775;10921.453927303603;19384.612307753767;19656.410307690792;19788.604227915363;19863.106160222826;19887.204511819655;6375.71309291083;6376;6452.193475815523;6457.580257283355;6529.575577587441;3412.078738740526;3489;3530.240998185351;3531.770434921722;3559.199180184438;2632.2761240658974;2639.4853003664102;2677.3306673331667;2699.3656490724666;2717.402171522262;471.89382388962207;474.46770654172184;474.995250047502;475.09020226267;481.2636665901177;573.827851644505;578.9531177072234;598.7156100852061;604.8760004199129;622.6637615687569;7541.585212813348;7839.568823714751;7919.366450683931;7938.364930805522;7943;564.1819361925225;571.0577547047405;592.2774215457135;600.207725801946;610.7740136149653;3633.073566240592;3655.2324011957253;3715.498407714978;3772.7359084864347;3852.2295540891932;67262.66368668224;67302.66348668323;67788.66105669539;70015;70074.29925700779;57027.42972570304;57900.420995790344;57961.4203857956;59339.406605933385;60544.39455605476;51453.22820157626;51480.22779658308;52166.21750673667;52453.21320180124;52680;7327.60983193238;7435.591042492715;7447.702091916262;7464.328210461084;7478.252174782696;36033.81983090068;36396;36934.445983309735;37461.625383746905;38090.80954595209;39399.40900886431;39919;41605.959851003965;45329.773351134354;46016.53983460256;11266.718332041764;11331.419432385841;11403.429828508708;11418.714532136763;11433.256838305484;12408.875911240772;12603.117781755189;12633.431495582538;12721.402582863511;12887.677808054874;11866.584669536525;11895.524179033087;11946.641600751991;12045.156839021185;12575.685607859878;10713.732156696145;10779.67660970172;10867.673969780919;11344.9432752839;11919.880801192225;11023.669289921316;11692.240004399688;11735.882641173479;11765;13078;10094.949525252621;10553.8944610556;11068.944655276671;11071.667849964513;11211.327320360804;8735.30117590604;9372.250219982521;9505.239580833655;9569.425834449956;9593.411227704375 07:22:56 INFO - PROCESS | 18214 | __end_tp_report 07:22:56 INFO - PROCESS | 18214 | __start_cc_report 07:22:56 INFO - PROCESS | 18214 | _x_x_mozilla_cycle_collect,1496 07:22:56 INFO - PROCESS | 18214 | __end_cc_report 07:22:56 INFO - PROCESS | 18214 | __startTimestamp1483543376514__endTimestamp 07:22:56 INFO - PROCESS | 18214 | 07:22:56 INFO - PROCESS | 18214 | ------- Summary: start ------- 07:22:56 INFO - PROCESS | 18214 | Number of tests: 6 07:22:56 INFO - PROCESS | 18214 | 07:22:56 INFO - PROCESS | 18214 | [#0] dojo.html Cycles:165 Average:4646.60 Median:4780.28 stddev:506.05 (10.6%) stddev-sans-first:480.01 07:22:56 INFO - PROCESS | 18214 | Values: 2545.5 2571.2 2594.1 2600.1 2601.3 4519.1 4587.3 4689.6 4729.5 4746.5 4589.6 4595.0 4604.4 4633.8 4663.4 4269.5 4305.2 4339.4 4370.1 4449.2 3952.8 4268.2 4387.0 4406.2 4457.6 4172.7 4197.3 4203.0 4285.8 4313.4 4229.0 4231.3 4236.0 4236.4 4237.0 4269.6 4313.8 4331.5 4367.3 4381.0 4640.8 4694.8 4723.0 4769.0 4771.5 5057.6 5064.1 5066.8 5069.2 5114.9 4885.8 4917.2 4930.1 5044.7 5089.1 4736.8 4759.6 4761.6 4802.5 4805.9 5186.2 5192.5 5194.4 5201.3 5244.3 4801.5 4845.7 4947.7 4980.0 5004.7 4976.6 4982.0 4982.3 4984.6 5026.3 5023.9 5049.0 5051.6 5055.4 5106.1 5038.2 5044.4 5048.8 5051.4 5097.2 4101.7 4126.3 4253.1 4256.4 4305.8 3666.0 3677.0 3694.3 3728.4 3733.7 4365.4 4368.4 4375.3 4379.2 4420.9 5047.7 5088.8 5092.6 5097.4 5141.5 4196.0 4214.4 4331.7 4353.7 4368.2 4585.7 4586.9 4600.4 4626.7 4626.8 4743.7 4745.9 4747.5 4750.8 4800.9 4901.9 4932.4 5094.5 5095.1 5134.0 4732.9 4770.5 4779.6 4780.3 4825.8 4805.9 4842.3 4844.1 5020.2 5027.5 5021.7 5049.2 5061.7 5074.5 5081.8 4776.5 4815.6 4931.4 4936.2 4941.6 4859.1 4861.9 4863.8 4864.1 4867.9 4778.0 4793.3 4798.8 4800.5 4840.7 4954.6 5010.5 5018.1 5049.5 5060.3 4877.3 4889.4 4893.3 4893.7 4936.2 07:22:56 INFO - PROCESS | 18214 | 07:22:56 INFO - PROCESS | 18214 | [#1] ext.html Cycles:180 Average:45969.11 Median:34775.13 stddev:77334.52 (222.4%) stddev-sans-first:77476.22 07:22:56 INFO - PROCESS | 18214 | Values: 531.9 563.5 570.5 586.4 592.2 35540.0 39457.2 39477.4 39502.2 39570.8 39065.4 39467.8 39595.8 39643.0 39675.0 7594.6 7719.1 7789.5 7900.7 7903.4 10066.2 10370.4 10373.2 10721.2 10734.5 10282.8 10341.2 10354.5 10371.5 10387.8 10240.6 10260.8 10286.9 10307.2 10309.8 10207.1 10262.3 10274.4 10279.1 10284.5 39315.6 39673.4 39700.8 39722.6 39748.0 3557.4 3692.2 3708.4 3739.3 3774.2 29392.0 29650.3 29767.1 30994.5 31193.8 3472.2 3558.5 3571.3 3582.5 3724.2 242132.0 243042.0 243378.0 243639.0 245674.0 56122.0 56606.7 56696.0 56728.4 56774.1 58812.0 59053.8 59100.7 59174.4 59191.7 14678.1 15150.8 15165.6 15166.8 15167.3 10598.4 10810.5 10831.7 11135.9 11323.9 16170.5 17526.3 17734.5 17829.4 18368.4 6071.5 6290.2 6330.6 6344.0 6397.6 745.2 754.0 758.1 779.3 781.3 27327.3 28481.7 28497.9 28806.9 28991.7 949.5 967.2 970.3 983.1 999.2 14646.6 15084.7 15302.4 15354.5 15490.8 343902.0 346229.0 346303.0 346461.0 346698.0 51260.7 51334.0 51462.2 51510.0 51530.5 1207.3 1245.5 1257.0 1258.1 1258.1 25195.4 26720.2 27042.5 27398.7 27483.9 43555.0 44098.3 44128.8 44154.3 44165.0 287172.0 287694.0 287960.0 289320.0 289852.0 37372.6 37846.0 37976.8 38190.8 38245.0 39572.8 39703.4 39787.2 39858.4 40475.2 34395.8 34723.3 34926.5 35238.3 35481.0 34795.5 34954.5 35273.3 35286.8 35344.8 33405.8 34089.3 34754.8 34846.0 35065.0 29548.9 31209.2 31286.2 31771.2 31955.2 23806.5 24199.4 24281.7 24478.6 24548.4 07:22:56 INFO - PROCESS | 18214 | 07:22:56 INFO - PROCESS | 18214 | [#2] jquery.html Cycles:180 Average:23853.75 Median:48923.27 stddev:57960.73 (118.5%) stddev-sans-first:58096.43 07:22:56 INFO - PROCESS | 18214 | Values: 338.0 338.7 351.7 355.2 375.8 12740.6 15639.4 16407.2 16419.9 17604.7 16978.5 17132.3 17164.5 17199.8 17561.6 4179.1 4955.2 5131.2 5132.5 5144.7 5025.0 5034.3 5034.4 5069.4 5082.3 5016.4 5021.4 5028.5 5036.2 5038.6 5213.2 5278.4 5290.4 5290.6 5292.0 4984.8 5107.7 5140.0 5140.4 5141.9 19538.6 19845.1 19846.6 21729.7 22267.1 2263.1 2278.0 2392.4 2454.2 2591.4 13066.7 14048.7 14527.2 14648.5 14911.3 1834.5 1873.8 1884.7 1889.8 1928.1 76544.0 77817.0 79430.0 79858.2 80791.0 17463.2 17712.5 17768.2 17885.2 17885.7 30721.8 30733.1 30735.4 30829.4 31210.4 8715.9 8855.4 9017.2 9076.3 9266.2 7281.6 7291.9 7308.5 7448.7 7485.5 8645.4 8982.4 9115.2 9139.9 9256.7 3537.4 3720.0 3752.9 3785.5 3904.5 789.0 808.7 809.6 810.4 831.3 14639.7 14884.9 14968.2 15160.9 15467.9 758.7 772.0 800.7 807.5 810.5 8259.0 8413.7 8919.8 9049.7 9087.0 339728.0 349849.0 353319.0 353754.0 354171.0 52622.5 57283.0 73298.3 74860.0 75762.6 855.5 877.6 895.2 896.7 898.4 13749.5 13772.8 13828.9 13865.5 14276.2 32458.7 34092.7 34320.8 34706.7 35918.3 38270.2 48078.0 48838.3 49008.3 49386.5 7108.1 7155.0 7312.5 7406.1 7467.5 9869.5 11277.2 11386.0 11540.0 11884.9 9917.3 10066.5 10092.7 10397.2 10449.4 9433.8 9474.2 9664.5 10303.5 10632.7 9832.4 9978.4 10036.7 10249.4 10303.2 7329.0 7451.1 7481.7 7752.3 7793.0 9171.6 10058.4 10061.1 10168.2 10471.0 07:22:56 INFO - PROCESS | 18214 | 07:22:56 INFO - PROCESS | 18214 | [#3] mootools.html Cycles:180 Average:4533.54 Median:5471.99 stddev:2405.87 (44.0%) stddev-sans-first:2400.60 07:22:56 INFO - PROCESS | 18214 | Values: 1333.3 1339.0 1345.0 1348.3 1350.8 6673.4 6963.3 6966.2 6971.1 6977.0 6073.2 6250.7 6641.3 6806.1 6907.3 1905.4 1927.9 1932.1 1933.1 1934.0 2007.4 2069.1 2073.3 2088.5 2097.1 1798.8 1854.7 2003.4 2048.7 2054.1 2060.2 2061.1 2069.4 2071.4 2081.1 1951.7 1967.3 1971.4 1972.5 1978.5 6815.7 6968.4 7091.3 7101.0 7107.4 4142.7 4259.9 4268.3 4278.9 4285.4 2642.7 2728.2 2791.7 2792.3 2800.2 952.4 996.6 1034.8 1035.6 1690.2 8778.4 8898.6 8920.8 8938.4 8941.6 3571.4 3766.4 3787.7 3793.1 3801.7 7306.2 7315.2 7325.5 7331.8 7333.9 4209.2 4209.6 4209.7 4212.6 4216.4 3799.7 3892.4 3904.6 3905.6 3906.8 2988.8 3007.8 3068.9 3082.3 3085.2 897.6 906.5 913.3 925.1 926.3 848.4 869.0 874.4 897.0 902.1 4839.2 5028.7 5030.4 5178.7 5205.9 900.6 924.3 925.1 939.4 973.5 3257.2 3401.3 3461.2 3474.1 3493.3 8134.3 8325.3 8400.9 8407.5 8432.5 8195.1 8224.0 8367.5 8374.0 8383.5 6443.5 6635.7 6635.8 6637.4 6653.1 4702.5 4797.6 4810.7 4840.3 4857.6 7425.9 7509.1 7531.2 7537.9 7538.5 7537.5 7734.7 7776.7 7779.3 7786.6 5521.4 5690.5 5736.8 5742.6 5757.1 6568.6 6643.5 6645.3 6647.7 6649.4 5829.7 5946.8 5976.4 5985.2 6070.6 5770.2 5779.2 5825.4 5838.4 5860.2 5383.8 5466.9 5468.8 5475.2 5476.8 4028.5 4030.3 4051.5 4161.9 4226.0 3951.7 4038.8 4051.1 4074.1 4106.9 07:22:56 INFO - PROCESS | 18214 | 07:22:56 INFO - PROCESS | 18214 | [#4] prototype.html Cycles:180 Average:4129.26 Median:4731.79 stddev:1210.37 (25.6%) stddev-sans-first:1179.22 07:22:56 INFO - PROCESS | 18214 | Values: 303.9 318.5 324.7 331.5 331.5 4655.5 4781.3 4900.7 4901.1 4918.8 4589.8 4823.3 4830.2 4834.6 4835.5 3736.8 3737.1 3750.5 3755.2 3772.4 3613.8 3640.6 3688.4 3744.7 3756.6 3678.2 3680.8 3692.4 3696.3 3716.3 3679.2 3680.4 3685.6 3699.0 3700.5 3083.3 3118.8 3174.0 3187.4 3228.7 4714.5 4717.9 4736.6 4738.0 4753.9 4127.6 4193.3 4198.2 4216.0 4228.5 4809.6 5016.0 5073.0 5088.2 5089.9 3518.6 3525.5 3525.6 3529.4 3542.1 5288.8 5307.5 5321.7 5322.6 5325.1 3615.4 3625.0 3636.2 3641.5 3643.4 3559.3 3612.6 3645.0 3655.8 3659.9 4049.7 4120.6 4142.8 4202.9 4210.6 5029.8 5061.4 5072.3 5077.2 5079.7 1222.0 1232.6 1236.7 1237.2 1245.5 830.3 831.4 837.3 844.2 852.2 4353.5 4354.7 4362.5 4370.0 4388.5 5080.9 5086.3 5088.7 5091.8 5109.5 4220.9 4360.3 4390.5 4392.6 4393.2 2630.5 2649.8 2652.0 2696.5 2696.8 4661.5 4679.2 4710.2 4759.4 4781.8 5019.3 5189.7 5209.3 5213.2 5239.7 4723.0 4742.8 4744.9 4747.8 4750.5 5076.3 5091.0 5094.9 5104.3 5105.3 4777.3 4984.5 4998.4 5000.0 5004.2 4719.3 4722.5 4727.0 4750.7 4752.7 3547.8 3552.4 3569.3 3572.0 3576.4 4874.3 5076.3 5097.2 5105.2 5110.5 4931.8 4938.7 4940.4 4948.0 4959.1 4950.9 4981.0 4983.8 5020.6 5024.8 4751.6 4916.9 4919.7 4928.8 4939.0 5093.3 5097.8 5098.5 5107.8 5110.9 4967.6 4970.0 4972.4 4981.5 5003.8 07:22:56 INFO - PROCESS | 18214 | 07:22:56 INFO - PROCESS | 18214 | [#5] yui.html Cycles:180 Average:14908.78 Median:4123.81 stddev:18629.88 (451.8%) stddev-sans-first:18651.43 07:22:56 INFO - PROCESS | 18214 | Values: 661.5 684.3 729.8 753.3 765.6 12814.4 13575.8 13594.3 13653.7 13686.7 11905.8 11989.8 12001.5 12010.5 12013.4 669.7 677.5 784.9 791.9 811.2 805.5 834.6 834.8 835.4 836.1 868.9 868.9 869.0 869.5 869.6 693.2 699.1 820.1 865.3 865.3 620.3 627.7 629.3 629.3 629.7 13112.5 13124.6 13155.7 13171.6 13181.8 13110.3 13128.8 13142.6 13156.0 13209.9 11794.8 11874.2 11878.3 12069.5 12137.7 4033.6 4040.0 4070.2 4118.2 4129.4 61092.0 61516.4 63737.4 64365.0 64931.0 10159.6 10415.7 10458.9 10506.3 10921.5 19384.6 19656.4 19788.6 19863.1 19887.2 6375.7 6376.0 6452.2 6457.6 6529.6 3412.1 3489.0 3530.2 3531.8 3559.2 2632.3 2639.5 2677.3 2699.4 2717.4 471.9 474.5 475.0 475.1 481.3 573.8 579.0 598.7 604.9 622.7 7541.6 7839.6 7919.4 7938.4 7943.0 564.2 571.1 592.3 600.2 610.8 3633.1 3655.2 3715.5 3772.7 3852.2 67262.7 67302.7 67788.7 70015.0 70074.3 57027.4 57900.4 57961.4 59339.4 60544.4 51453.2 51480.2 52166.2 52453.2 52680.0 7327.6 7435.6 7447.7 7464.3 7478.3 36033.8 36396.0 36934.4 37461.6 38090.8 39399.4 39919.0 41606.0 45329.8 46016.5 11266.7 11331.4 11403.4 11418.7 11433.3 12408.9 12603.1 12633.4 12721.4 12887.7 11866.6 11895.5 11946.6 12045.2 12575.7 10713.7 10779.7 10867.7 11344.9 11919.9 11023.7 11692.2 11735.9 11765.0 13078.0 10094.9 10553.9 11068.9 11071.7 11211.3 8735.3 9372.3 9505.2 9569.4 9593.4 07:22:56 INFO - PROCESS | 18214 | -------- Summary: end -------- 07:22:56 INFO - PROCESS | 18214 | 07:22:57 INFO - TEST-INFO | 18214: exit 0 07:22:57 INFO - TEST-OK | dromaeo_css | took 1121147ms 07:22:57 INFO - TEST-START | kraken 07:22:57 INFO - operating with platform_type : linux_ 07:22:57 INFO - Initialising browser for kraken test... 07:22:57 INFO - TEST-INFO | started process 18516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYbnf7q/profile http://localhost:52415/getInfo.html) 07:22:57 INFO - PROCESS | 18516 | 1483543377845 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4901 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3756 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2789 < callProvider()@resource://gre/modules/AddonManager.jsm:260 < _startProvider()@resource://gre/modules/AddonManager.jsm:755 < startup()@resource://gre/modules/AddonManager.jsm:937 < startup()@resource://gre/modules/AddonManager.jsm:2886 < observe()@resource://gre/components/addonManager.js:65 07:23:01 INFO - PROCESS | 18516 | __metrics Screen width/height:1600/1200 07:23:01 INFO - PROCESS | 18516 | colorDepth:24 07:23:01 INFO - PROCESS | 18516 | Browser inner width/height: 1024/697 07:23:01 INFO - PROCESS | 18516 | __metrics 07:23:01 INFO - PROCESS | 18516 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:23:01 INFO - PROCESS | 18516 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:23:02 INFO - PROCESS | 18516 | console.error: PushService: 07:23:02 INFO - PROCESS | 18516 | stateChangeProcessEnqueue: Error transitioning state 07:23:02 INFO - PROCESS | 18516 | UnknownError 07:23:03 INFO - TEST-INFO | 18516: exit 0 07:23:03 INFO - Browser initialized. 07:23:03 INFO - Running cycle 1/1 for kraken test... 07:23:03 INFO - TEST-INFO | started process 18598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYbnf7q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:15 INFO - PROCESS | 18598 | RSS: Main: 151982080 07:23:15 INFO - PROCESS | 18598 | 07:23:18 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52415/tests/kraken/driver.html?testName=audio-beat-detection) 07:23:19 INFO - PROCESS | 18598 | RSS: Main: 205381632 07:23:19 INFO - PROCESS | 18598 | 07:23:21 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52415/tests/kraken/driver.html?testName=audio-dft) 07:23:22 INFO - PROCESS | 18598 | RSS: Main: 185319424 07:23:22 INFO - PROCESS | 18598 | 07:23:25 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52415/tests/kraken/driver.html?testName=audio-fft) 07:23:26 INFO - PROCESS | 18598 | RSS: Main: 267935744 07:23:26 INFO - PROCESS | 18598 | 07:23:28 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52415/tests/kraken/driver.html?testName=audio-oscillator) 07:23:28 INFO - PROCESS | 18598 | RSS: Main: 179085312 07:23:28 INFO - PROCESS | 18598 | 07:23:31 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52415/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:23:31 INFO - PROCESS | 18598 | RSS: Main: 182681600 07:23:31 INFO - PROCESS | 18598 | 07:23:34 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52415/tests/kraken/driver.html?testName=imaging-darkroom) 07:23:35 INFO - PROCESS | 18598 | RSS: Main: 221233152 07:23:35 INFO - PROCESS | 18598 | 07:23:38 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52415/tests/kraken/driver.html?testName=imaging-desaturate) 07:23:39 INFO - PROCESS | 18598 | RSS: Main: 215515136 07:23:39 INFO - PROCESS | 18598 | 07:23:42 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52415/tests/kraken/driver.html?testName=json-parse-financial) 07:23:43 INFO - PROCESS | 18598 | RSS: Main: 216723456 07:23:43 INFO - PROCESS | 18598 | 07:23:44 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52415/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:23:45 INFO - PROCESS | 18598 | RSS: Main: 180879360 07:23:45 INFO - PROCESS | 18598 | 07:23:47 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52415/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:23:47 INFO - PROCESS | 18598 | RSS: Main: 188166144 07:23:47 INFO - PROCESS | 18598 | 07:23:50 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52415/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:23:50 INFO - PROCESS | 18598 | RSS: Main: 195891200 07:23:50 INFO - PROCESS | 18598 | 07:23:53 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:23:54 INFO - PROCESS | 18598 | RSS: Main: 200265728 07:23:54 INFO - PROCESS | 18598 | 07:23:57 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:23:57 INFO - PROCESS | 18598 | RSS: Main: 202596352 07:23:57 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | Cycle 1(1): loaded http://localhost:52415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52415/tests/kraken/driver.html?testName=ai-astar) 07:23:59 INFO - PROCESS | 18598 | RSS: Main: 253603840 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | __start_tp_report 07:23:59 INFO - PROCESS | 18598 | _x_x_mozilla_page_load 07:23:59 INFO - PROCESS | 18598 | _x_x_mozilla_page_load_details 07:23:59 INFO - PROCESS | 18598 | |i|pagename|runs| 07:23:59 INFO - PROCESS | 18598 | |0;ai-astar;105;118;113;114;114;114;114;114;117;115 07:23:59 INFO - PROCESS | 18598 | |1;audio-beat-detection;159;134;125;172;129;129;127;125;158;127 07:23:59 INFO - PROCESS | 18598 | |2;audio-dft;163;162;160;162;162;163;161;163;161;161 07:23:59 INFO - PROCESS | 18598 | |3;audio-fft;76;76;75;117;77;76;77;78;92;75 07:23:59 INFO - PROCESS | 18598 | |4;audio-oscillator;85;84;105;84;85;85;100;84;85;114 07:23:59 INFO - PROCESS | 18598 | |5;imaging-gaussian-blur;117;117;118;117;117;117;118;117;117;117 07:23:59 INFO - PROCESS | 18598 | |6;imaging-darkroom;150;149;150;150;149;150;149;149;150;149 07:23:59 INFO - PROCESS | 18598 | |7;imaging-desaturate;95;95;96;96;96;96;96;95;97;95 07:23:59 INFO - PROCESS | 18598 | |8;json-parse-financial;64;62;62;63;61;63;62;63;63;70 07:23:59 INFO - PROCESS | 18598 | |9;json-stringify-tinderbox;68;68;67;68;68;68;67;68;69;67 07:23:59 INFO - PROCESS | 18598 | |10;stanford-crypto-aes;85;84;83;83;93;87;86;85;84;83 07:23:59 INFO - PROCESS | 18598 | |11;stanford-crypto-ccm;132;148;140;131;130;131;131;131;207;141 07:23:59 INFO - PROCESS | 18598 | |12;stanford-crypto-pbkdf2;177;174;173;174;174;176;177;174;184;176 07:23:59 INFO - PROCESS | 18598 | |13;stanford-crypto-sha256-iterative;72;68;69;68;73;69;68;67;66;66 07:23:59 INFO - PROCESS | 18598 | __end_tp_report 07:23:59 INFO - PROCESS | 18598 | __start_cc_report 07:23:59 INFO - PROCESS | 18598 | _x_x_mozilla_cycle_collect,1823 07:23:59 INFO - PROCESS | 18598 | __end_cc_report 07:23:59 INFO - PROCESS | 18598 | __startTimestamp1483543439933__endTimestamp 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | ------- Summary: start ------- 07:23:59 INFO - PROCESS | 18598 | Number of tests: 14 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:3.46 (3.0%) stddev-sans-first:1.64 07:23:59 INFO - PROCESS | 18598 | Values: 105.0 118.0 113.0 114.0 114.0 114.0 114.0 114.0 117.0 115.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:131.50 stddev:17.49 (13.3%) stddev-sans-first:16.90 07:23:59 INFO - PROCESS | 18598 | Values: 159.0 134.0 125.0 172.0 129.0 129.0 127.0 125.0 158.0 127.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 07:23:59 INFO - PROCESS | 18598 | Values: 163.0 162.0 160.0 162.0 162.0 163.0 161.0 163.0 161.0 161.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.50 stddev:13.32 (17.4%) stddev-sans-first:13.96 07:23:59 INFO - PROCESS | 18598 | Values: 76.0 76.0 75.0 117.0 77.0 76.0 77.0 78.0 92.0 75.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:84.50 stddev:11.04 (13.1%) stddev-sans-first:11.49 07:23:59 INFO - PROCESS | 18598 | Values: 85.0 84.0 105.0 84.0 85.0 85.0 100.0 84.0 85.0 114.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:23:59 INFO - PROCESS | 18598 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:150.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:23:59 INFO - PROCESS | 18598 | Values: 150.0 149.0 150.0 150.0 149.0 150.0 149.0 149.0 150.0 149.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 07:23:59 INFO - PROCESS | 18598 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 95.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.00 stddev:2.50 (4.0%) stddev-sans-first:2.64 07:23:59 INFO - PROCESS | 18598 | Values: 64.0 62.0 62.0 63.0 61.0 63.0 62.0 63.0 63.0 70.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 07:23:59 INFO - PROCESS | 18598 | Values: 68.0 68.0 67.0 68.0 68.0 68.0 67.0 68.0 69.0 67.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:3.02 (3.6%) stddev-sans-first:3.20 07:23:59 INFO - PROCESS | 18598 | Values: 85.0 84.0 83.0 83.0 93.0 87.0 86.0 85.0 84.0 83.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:136.00 stddev:23.56 (17.3%) stddev-sans-first:24.69 07:23:59 INFO - PROCESS | 18598 | Values: 132.0 148.0 140.0 131.0 130.0 131.0 131.0 131.0 207.0 141.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:176.00 stddev:3.18 (1.8%) stddev-sans-first:3.35 07:23:59 INFO - PROCESS | 18598 | Values: 177.0 174.0 173.0 174.0 174.0 176.0 177.0 174.0 184.0 176.0 07:23:59 INFO - PROCESS | 18598 | 07:23:59 INFO - PROCESS | 18598 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:2.32 (3.4%) stddev-sans-first:2.11 07:23:59 INFO - PROCESS | 18598 | Values: 72.0 68.0 69.0 68.0 73.0 69.0 68.0 67.0 66.0 66.0 07:23:59 INFO - PROCESS | 18598 | -------- Summary: end -------- 07:23:59 INFO - PROCESS | 18598 | 07:24:01 INFO - TEST-INFO | 18598: exit 0 07:24:01 INFO - TEST-OK | kraken | took 63764ms 07:24:01 INFO - SUITE-END | took 1184s 07:24:01 INFO - Completed test suite (00:19:45) 07:24:01 INFO - javascript benchmark 07:24:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2545.465452255027, 2571.2286314105763, 2594.1309661263476, 2600.089968511021, 2601.336659151917, 4519.096180763844, 4587.2889702096145, 4689.648276379268, 4729.527047295273, 4746.525347465256, 4589.609883159927, 4595.03504264105, 4604.4014278143795, 4633.791479383427, 4663.417072865892, 4269.530351661315, 4305.160493703729, 4339.392485052095, 4370.147821174872, 4449.199144154051, 3952.7733246273506, 4268.231718290706, 4387.0129220925355, 4406.206882761102, 4457.621102206316, 4172.666186705056, 4197.307444271692, 4203.033302340448, 4285.764282964436, 4313.4176886120285, 4229.0273237155625, 4231.322988321854, 4236.04688944988, 4236.364545318196, 4237.025484138635, 4269.573042695737, 4313.805878735465, 4331.523532411432, 4367.301231802896, 4380.956190438087, 4640.767961601907, 4694.835680751192, 4723.031778485402, 4769.0, 4771.522847715235, 5057.595392368602, 5064.063148317537, 5066.847994560169, 5069.239614057921, 5114.872128196787, 4885.804567817283, 4917.164082106051, 4930.137225985438, 5044.722540260284, 5089.134847076006, 4736.786844592001, 4759.571638552477, 4761.571458568746, 4802.47172810994, 4805.8558243252755, 5186.222066690027, 5192.4547922468355, 5194.35070616173, 5201.3238279024245, 5244.344456942882, 4801.51984801517, 4845.6608037437045, 4947.675518515211, 4979.950200498021, 5004.749762511859, 4976.552110310089, 4982.0, 4982.252662100714, 4984.576311013532, 5026.321446604735, 5023.949760502422, 5049.0, 5051.621128415383, 5055.368078990126, 5106.131957567222, 5038.2190760432195, 5044.419891712427, 5048.798048078109, 5051.393832740095, 5097.235414687752, 4101.651359634465, 4126.339785634284, 4253.064325848309, 4256.3828244904935, 4305.784710764449, 3666.046827824785, 3676.963230367662, 3694.3165514379925, 3728.4034554471154, 3733.7386382953478, 4365.388845561624, 4368.4321038264825, 4375.321825117112, 4379.189849877783, 4420.9336859947125, 5047.722375269395, 5088.847334579968, 5092.6180536459915, 5097.362829646294, 5141.485851414904, 4195.958040419557, 4214.388913607571, 4331.6534677225745, 4353.69524133314, 4368.213721530155, 4585.701929374647, 4586.945002649342, 4600.378948841931, 4626.699264547794, 4626.791794369262, 4743.715377077387, 4745.881352966204, 4747.477777444409, 4750.762461876961, 4800.903981920412, 4901.877453063559, 4932.4327702314695, 5094.490550944876, 5095.133827249302, 5134.0, 4732.858014259577, 4770.475247722818, 4779.641526885428, 4780.282957556395, 4825.782839772289, 4805.879853003703, 4842.273658951185, 4844.128056949783, 5020.171671674133, 5027.522385373383, 5021.748912554431, 5049.2173713074535, 5061.7469126544265, 5074.517920797666, 5081.7713202905215, 4776.522347765195, 4815.590674792682, 4931.432885218246, 4936.234883593049, 4941.604671626189, 4859.149648811514, 4861.902761944671, 4863.805447782049, 4864.075825593268, 4867.90264194707, 4778.04439112172, 4793.304970779148, 4798.7840547174765, 4800.543948324904, 4840.709557426566, 4954.628402869727, 5010.473900240422, 5018.071656743514, 5049.545540901337, 5060.3168572242275, 4877.341558889504, 4889.364382630235, 4893.266010098514, 4893.7063776173545, 4936.2102063669645], "value": 4613.131050607248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.9095753721867, 563.5181919458862, 570.463764061782, 586.4371450085522, 592.1532208941218, 35540.0, 39457.210855782905, 39477.40783888244, 39502.20995580087, 39570.8021459893, 39065.41401878974, 39467.80266098666, 39595.802020989926, 39643.00892477683, 39675.0, 7594.620268986556, 7719.112302085262, 7789.454738168331, 7900.683972641087, 7903.40724445666, 10066.24503162262, 10370.429626370547, 10373.170146388271, 10721.249512534127, 10734.463276836166, 10282.845757313646, 10341.224408169379, 10354.482275886214, 10371.48142592871, 10387.792244155113, 10240.590376384936, 10260.794784104351, 10286.897131028669, 10307.175425965905, 10309.793804123912, 10207.13239374654, 10262.281640285182, 10274.434906080163, 10279.074883260542, 10284.537195826131, 39315.60684393177, 39673.404898926536, 39700.80149599262, 39722.602773972176, 39748.0, 3557.3596752584526, 3692.2061756722433, 3708.35103856824, 3739.2708421857747, 3774.1885494618787, 29392.0, 29650.25874353137, 29767.10698679043, 30994.535081973787, 31193.84403077993, 3472.2187507810795, 3558.5018097466377, 3571.3035957988204, 3582.4805403216387, 3724.1620635356826, 242132.0, 243042.0, 243378.0, 243639.0, 245674.0, 56122.0, 56606.716966415726, 56696.0, 56728.43271567314, 56774.148387774214, 58812.0, 59053.818923621286, 59100.70449647724, 59174.40825591689, 59191.70404147952, 14678.119312841263, 15150.772738408932, 15165.620859478602, 15166.772498412533, 15167.317470713844, 10598.364098154136, 10810.513526891309, 10831.67504974852, 11135.944320278346, 11323.886761132448, 16170.514884553482, 17526.298948041935, 17734.46796596104, 17829.375971840924, 18368.357107501175, 6071.544634152457, 6290.24517057956, 6330.556861019684, 6343.968280158662, 6397.584157029778, 745.1877453575629, 753.9736109236151, 758.135725273189, 779.2713812585251, 781.3202513813019, 27327.316817079336, 28481.715182848322, 28497.857510712314, 28806.85596572004, 28991.710082898902, 949.4967667136428, 967.1778987860263, 970.2868391732071, 983.1446641422009, 999.2355847776457, 14646.633834154018, 15084.698306033817, 15302.416538622792, 15354.462593809163, 15490.845091549165, 343902.0, 346229.0, 346303.0, 346461.0, 346698.0, 51260.74369628128, 51333.99999999925, 51462.22806657903, 51510.0, 51530.48469515332, 1207.2575366149754, 1245.5017992802589, 1257.0258050011314, 1258.069028918612, 1258.144461766008, 25195.370115747253, 26720.19839404821, 27042.45915081648, 27398.72601273962, 27483.862580686968, 43555.0, 44098.33852492151, 44128.77935610301, 44154.33768493411, 44165.0, 287172.0, 287694.0, 287960.0, 289320.0, 289852.0, 37372.62627373692, 37846.0, 37976.81011594924, 38190.80904595459, 38245.0, 39572.802135989135, 39703.40444893387, 39787.2042559153, 39858.402123967586, 40475.1904961905, 34395.796147135734, 34723.30553388969, 34926.47610285797, 35238.295234094665, 35481.0, 34795.47806782951, 34954.47568286528, 35273.294534109686, 35286.823565882005, 35344.82327588346, 33405.83297083499, 34089.318213635095, 34754.78358257449, 34846.0, 35065.0, 29548.852255738584, 31209.219769505034, 31286.217844554067, 31771.20571985719, 31955.201119972186, 23806.523869522858, 24199.395015124763, 24281.709005312616, 24478.63282050735, 24548.38629034217], "value": 18157.88742358915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.9814110223937, 338.7459405445914, 351.7484998226268, 355.22560817418025, 375.8308761057523, 12740.617781466559, 15639.374425023, 16407.17964101796, 16419.91790041048, 17604.735928961076, 16978.49064528063, 17132.31470741169, 17164.485065448025, 17199.82800171998, 17561.56096097598, 4179.101493178966, 4955.157623204055, 5131.2303154526935, 5132.486751324875, 5144.6913185209005, 5025.04524140414, 5034.295198672189, 5034.42104158021, 5069.44236134025, 5082.313887625179, 5016.3980322361185, 5021.422536408305, 5028.522290382408, 5036.169032109698, 5038.59691224703, 5213.165893457048, 5278.366596008465, 5290.418054014055, 5290.57675385972, 5292.020976119411, 4984.77568509418, 5107.693538387672, 5140.049090918192, 5140.434552199293, 5141.948580514184, 19538.609227815505, 19845.106970186233, 19846.603067938562, 21729.67405488919, 22267.109315627356, 2263.1400067974228, 2277.9658305125436, 2392.4018995251186, 2454.2023842251338, 2591.3521619595103, 13066.673333166651, 14048.681967475355, 14527.20100394478, 14648.487302944346, 14911.254437278092, 1834.5413646588354, 1873.8219869112413, 1884.689026310657, 1889.763779527559, 1928.1227041695995, 76543.99999999945, 77817.0, 79430.0, 79858.20141798566, 80791.0, 17463.21415536304, 17712.46862594124, 17768.200430980636, 17885.195166217552, 17885.7317140243, 30721.846390767903, 30733.078007659806, 30735.385292294475, 30829.383412331626, 31210.375792484025, 8715.91284087151, 8855.38012339143, 9017.188453039258, 9076.31927605419, 9266.193092347063, 7281.577658500496, 7291.927080729125, 7308.451866110063, 7448.702051917862, 7485.513441626277, 8645.394822362374, 8982.371234013686, 9115.225205857443, 9139.908600913906, 9256.72229833106, 3537.398642230827, 3719.9814000929823, 3752.887413377603, 3785.545734511876, 3904.531456225271, 788.9526628402314, 808.7452452477569, 809.5830647216688, 810.3841080778533, 831.3141658132065, 14639.707205855822, 14884.916111744364, 14968.17675027862, 15160.924195378953, 15467.922660386626, 758.6737702787855, 772.0, 800.6597196191595, 807.5477732469835, 810.5177419435427, 8259.0, 8413.655619237477, 8919.777005574782, 9049.665354036028, 9087.0, 339728.0, 349849.0, 353319.0, 353754.0, 354171.0, 52622.47377526252, 57283.0, 73298.26701733022, 74860.0, 75762.62118689371, 855.5096734725062, 877.6138499060393, 895.2256298301922, 896.6906417286026, 898.4070513461215, 13749.456350575176, 13772.793408098687, 13828.93085534566, 13865.51470698561, 14276.21480818565, 32458.675413245564, 34092.65907340994, 34320.82839585786, 34706.652933470345, 35918.28163436664, 38270.234595308495, 48078.0, 48838.26742598793, 49008.2648760276, 49386.506134938194, 7108.147022357351, 7155.0, 7312.5246858954, 7406.111266648037, 7467.514611550232, 9869.506524673881, 11277.154213433862, 11386.0, 11540.0, 11884.940575297069, 9917.256205784739, 10066.547005384922, 10092.747681308027, 10397.220208484243, 10449.373037617766, 9433.764155896157, 9474.242060634995, 9664.513378316038, 10303.484825758833, 10632.681019569425, 9832.360896541702, 9978.351407158512, 10036.698899033041, 10249.38503689751, 10303.175745940156, 7329.0, 7451.105867295959, 7481.663325150273, 7752.302292793675, 7793.012162533449, 9171.587278572346, 10058.380320343413, 10061.144802691853, 10168.186545076229, 10471.0], "value": 8798.877734223466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.3466601365328, 1338.9665258368539, 1345.0382976172034, 1348.3190988550787, 1350.7568637645227, 6673.366030227126, 6963.303669633035, 6966.16406031277, 6971.09375781149, 6976.965115174424, 6073.240844894388, 6250.718717657705, 6641.302663220365, 6806.081179040828, 6907.30926907309, 1905.3617038292155, 1927.8650494465394, 1932.0726051495292, 1933.0528041259752, 1934.032983508246, 2007.42788305333, 2069.068918986462, 2073.2639912830955, 2088.467440802601, 2097.0772859941576, 1798.7841459024935, 1854.7310639957198, 2003.378952524722, 2048.6926960955825, 2054.075665950321, 2060.1965233559, 2061.051916118587, 2069.4412508622736, 2071.4200023993308, 2081.1467298407733, 1951.6877299632133, 1967.3212741604123, 1971.418431562678, 1972.4970132616234, 1978.5350442645968, 6815.693293801791, 6968.44252459802, 7091.25541818112, 7101.0, 7107.360337569644, 4142.71001029928, 4259.8509052183335, 4268.253055715238, 4278.893027674302, 4285.442892423996, 2642.735726427361, 2728.1679087878188, 2791.665000199989, 2792.3298408381843, 2800.2159395369126, 952.3857112162616, 996.5764550066193, 1034.8344264917653, 1035.554711474066, 1690.2478397113289, 8778.385513014091, 8898.644054237888, 8920.821583568293, 8938.419002764864, 8941.552922353922, 3571.3571557119967, 3766.39737641976, 3787.7348585598743, 3793.1275806564645, 3801.657850793442, 7306.159791624032, 7315.158756742936, 7325.450591205575, 7331.816704582428, 7333.88999165013, 4209.17921005401, 4209.5790420957655, 4209.663226941837, 4212.620864122244, 4216.409702641633, 3799.696024318048, 3892.4355968384994, 3904.590018048064, 3905.6094390560716, 3906.7851268180525, 2988.835614041205, 3007.804492707967, 3068.861901214451, 3082.321889184376, 3085.167004908662, 897.5512243878061, 906.4606559097458, 913.3058875254854, 925.1026504290827, 926.346925417579, 848.3849209323315, 868.9826203475895, 874.3573473496974, 896.9955150224207, 902.0933961368913, 4839.153148199051, 5028.748562571856, 5030.37120359955, 5178.689278643294, 5205.947940520547, 900.5722281916037, 924.2605915267759, 925.0980294213089, 939.4081728510994, 973.4500007495742, 3257.218267615755, 3401.2857299967286, 3461.2385275239913, 3474.0967348489576, 3493.3013397320638, 8134.26791588748, 8325.292350150185, 8400.873986890201, 8407.53758543286, 8432.494050356998, 8195.139510351446, 8224.0, 8367.539785311745, 8374.036985746596, 8383.455075420079, 6443.5167362448, 6635.668216589248, 6635.834104147435, 6637.435817955431, 6653.068570400148, 4702.48272689997, 4797.64017698681, 4810.735409552368, 4840.346553215411, 4857.635677324285, 7425.925740742523, 7509.136449308399, 7531.209223031503, 7537.886931695919, 7538.547687138789, 7537.54774713519, 7734.690612375442, 7776.650050747843, 7779.260970207822, 7786.571738554434, 5521.3926468087675, 5690.487856092972, 5736.770529178786, 5742.598018138858, 5757.107648314518, 6568.638724870178, 6643.501737369813, 6645.269020407654, 6647.734090636321, 6649.368310010541, 5829.650220986754, 5946.791862284799, 5976.372480889618, 5985.191999080069, 6070.575059745952, 5770.163326317745, 5779.162021506774, 5825.417458254141, 5838.4453476919625, 5860.150278209721, 5383.757730902197, 5466.863328416822, 5468.808591699271, 5475.178723191394, 5476.835694929158, 4028.5165780105403, 4030.294698427822, 4051.4530538376944, 4161.916761664689, 4226.0, 3951.7431366962205, 4038.7980600969245, 4051.108756073659, 4074.083331250445, 4106.856260030884], "value": 3741.5806606967926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.92857678445546, 318.5365293497959, 324.654243230959, 331.4746127388089, 331.5308837994238, 4655.4878963314, 4781.330613714083, 4900.730459824713, 4901.093297739921, 4918.827841025565, 4589.793459294331, 4823.324734537167, 4830.160022781888, 4834.63740219484, 4835.5097124980575, 3736.794476303809, 3737.1030952571323, 3750.474933509311, 3755.2114056048126, 3772.3775577029755, 3613.765105268162, 3640.5813331466825, 3688.391415416453, 3744.6629803317696, 3756.624337566249, 3678.1907980244305, 3680.7791532508, 3692.3722967095523, 3696.2607478504274, 3716.2753263113705, 3679.22736225393, 3680.3743363628246, 3685.5761587417387, 3699.0, 3700.518932538753, 3083.290843106076, 3118.7972781769113, 3173.984130079358, 3187.3943950649536, 3228.677132286776, 4714.528547145293, 4717.882052948669, 4736.621070314367, 4737.9813340131695, 4753.928691069636, 4127.649149822269, 4193.287141186006, 4198.160367926396, 4215.978920105411, 4228.513720922103, 4809.615230781529, 5015.974920125376, 5073.0, 5088.23676448532, 5089.949100509021, 3518.577770667511, 3525.506429099928, 3525.6121826599056, 3529.400001999666, 3542.1321776164746, 5288.805145864461, 5307.548858347045, 5321.707306098163, 5322.600804939645, 5325.121354976385, 3615.439606860941, 3625.0, 3636.2182130841998, 3641.5448068990845, 3643.398839191557, 3559.2703495783303, 3612.6387361263664, 3644.9635503645154, 3655.8354874030733, 3659.908502287411, 4049.7367671101283, 4120.649744771668, 4142.813573389205, 4202.915941681149, 4210.5578914214175, 5029.798808047711, 5061.44324124346, 5072.289879416885, 5077.213031980049, 5079.74601269935, 1221.9755604887853, 1232.6055662188194, 1236.6537369536545, 1237.1772771107112, 1245.4768997021272, 830.2693629605908, 831.4055450353027, 837.3050368194506, 844.2190973349627, 852.1733918099434, 4353.477582690098, 4354.738715677069, 4362.541933096979, 4369.978150109229, 4388.451443569554, 5080.872978175576, 5086.338775959101, 5088.669236499616, 5091.7963281469065, 5109.514596113363, 4220.8895552223885, 4360.345948107746, 4390.473143222834, 4392.604665580113, 4393.231184542692, 2630.473905218964, 2649.827761195516, 2652.005497938273, 2696.474187533412, 2696.7864460992632, 4661.533846615312, 4679.181143299909, 4710.175719249118, 4759.405074365704, 4781.824269957161, 5019.268352418409, 5189.6886186828915, 5209.348831396075, 5213.168321283853, 5239.711815850089, 4723.0, 4742.786574604151, 4744.8849520362, 4747.762611869462, 4750.548697873696, 5076.314697515936, 5091.0, 5094.872628184176, 5104.336436263262, 5105.259737337991, 4777.331173635764, 4984.501549844987, 4998.350214472095, 5000.0, 5004.224345226496, 4719.268513380432, 4722.480527141943, 4726.952730472652, 4750.738709371018, 4752.738599376929, 3547.7693949893173, 3552.431610942237, 3569.268299998546, 3571.9642803571633, 3576.374134526395, 4874.26963427978, 5076.340075790271, 5097.209932460474, 5105.2342148678, 5110.48895110486, 4931.827386041471, 4938.654294199515, 4940.382452193476, 4947.975260123821, 4959.082569724468, 4950.905683947532, 4980.990302806131, 4983.775730092227, 5020.623453240948, 5024.773885175249, 4751.61987041029, 4916.934887347251, 4919.680220785637, 4928.827491037797, 4939.0, 5093.261477085876, 5097.7706003229205, 5098.490150984871, 5107.770150343169, 5110.872228194325, 4967.627427942991, 4969.950300496948, 4972.428170760409, 4981.4769449207315, 5003.849884503471], "value": 3751.093661756692, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.546840414316, 684.3327755438448, 729.8430837369964, 753.2994315286783, 765.5598031132099, 12814.423350949206, 13575.796363054538, 13594.320283985786, 13653.726925461497, 13686.657833554165, 11905.761884762322, 11989.760204795899, 12001.51993920242, 12010.45952932118, 12013.399330033508, 669.6819010969799, 677.529117263502, 784.8587254294225, 791.9089304729972, 811.1563973467587, 805.5166899860067, 834.5701963488777, 834.8330333933208, 835.419383528448, 836.0928392693935, 868.8783570300163, 868.9131086891324, 868.9608967596441, 869.4783130121939, 869.5565261716507, 693.2097408953797, 699.059764616595, 820.0937963550251, 865.3034307382586, 865.312076898867, 620.2928661326092, 627.7143899525705, 629.298332359416, 629.3329071184513, 629.7418058595954, 13112.541061062817, 13124.606261812161, 13155.736885262337, 13171.60485185446, 13181.802272965913, 13110.27893465859, 13128.803067953988, 13142.605721828264, 13156.0, 13209.86790132096, 11794.764104717857, 11874.228175168586, 11878.287302761775, 12069.517219311305, 12137.696557586043, 4033.6168064034164, 4039.9596004040172, 4070.1859628074208, 4118.19695159444, 4129.421880936671, 61092.0, 61516.38483615151, 63737.36262637361, 64365.0, 64931.0, 10159.644412445678, 10415.68752937413, 10458.895411045944, 10506.264561480775, 10921.453927303603, 19384.612307753767, 19656.410307690792, 19788.604227915363, 19863.106160222826, 19887.204511819655, 6375.71309291083, 6376.0, 6452.193475815523, 6457.580257283355, 6529.575577587441, 3412.078738740526, 3489.0, 3530.240998185351, 3531.770434921722, 3559.199180184438, 2632.2761240658974, 2639.4853003664102, 2677.3306673331667, 2699.3656490724666, 2717.402171522262, 471.89382388962207, 474.46770654172184, 474.995250047502, 475.09020226267, 481.2636665901177, 573.827851644505, 578.9531177072234, 598.7156100852061, 604.8760004199129, 622.6637615687569, 7541.585212813348, 7839.568823714751, 7919.366450683931, 7938.364930805522, 7943.0, 564.1819361925225, 571.0577547047405, 592.2774215457135, 600.207725801946, 610.7740136149653, 3633.073566240592, 3655.2324011957253, 3715.498407714978, 3772.7359084864347, 3852.2295540891932, 67262.66368668224, 67302.66348668323, 67788.66105669539, 70015.0, 70074.29925700779, 57027.42972570304, 57900.420995790344, 57961.4203857956, 59339.406605933385, 60544.39455605476, 51453.22820157626, 51480.22779658308, 52166.21750673667, 52453.21320180124, 52680.0, 7327.60983193238, 7435.591042492715, 7447.702091916262, 7464.328210461084, 7478.252174782696, 36033.81983090068, 36396.0, 36934.445983309735, 37461.625383746905, 38090.80954595209, 39399.40900886431, 39919.0, 41605.959851003965, 45329.773351134354, 46016.53983460256, 11266.718332041764, 11331.419432385841, 11403.429828508708, 11418.714532136763, 11433.256838305484, 12408.875911240772, 12603.117781755189, 12633.431495582538, 12721.402582863511, 12887.677808054874, 11866.584669536525, 11895.524179033087, 11946.641600751991, 12045.156839021185, 12575.685607859878, 10713.732156696145, 10779.67660970172, 10867.673969780919, 11344.9432752839, 11919.880801192225, 11023.669289921316, 11692.240004399688, 11735.882641173479, 11765.0, 13078.0, 10094.949525252621, 10553.8944610556, 11068.944655276671, 11071.667849964513, 11211.327320360804, 8735.30117590604, 9372.250219982521, 9505.239580833655, 9569.425834449956, 9593.411227704375], "value": 6291.102711691489, "unit": "score"}], "name": "dromaeo_css", "value": 6342.3120122401, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 117.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 134.0, 125.0, 172.0, 129.0, 129.0, 127.0, 125.0, 158.0, 127.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 162.0, 162.0, 163.0, 161.0, 163.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 117.0, 77.0, 76.0, 77.0, 78.0, 92.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 105.0, 84.0, 85.0, 85.0, 100.0, 84.0, 85.0, 114.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 150.0, 149.0, 150.0, 149.0, 149.0, 150.0, 149.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 63.0, 61.0, 63.0, 62.0, 63.0, 63.0, 70.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 69.0, 67.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 83.0, 93.0, 87.0, 86.0, 85.0, 84.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 148.0, 140.0, 131.0, 130.0, 131.0, 131.0, 131.0, 207.0, 141.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 173.0, 174.0, 174.0, 176.0, 177.0, 174.0, 184.0, 176.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 69.0, 68.0, 73.0, 69.0, 68.0, 67.0, 66.0, 66.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1552.6000000000001, "alertThreshold": 2.0}]} 07:24:01 INFO - Return code: 0 07:24:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:24:01 INFO - # TBPL SUCCESS # 07:24:01 INFO - Running post-action listener: _resource_record_post_action 07:24:01 INFO - [mozharness: 2017-01-04 15:24:01.728529Z] Finished run-tests step (success) 07:24:01 INFO - Running post-run listener: _resource_record_post_run 07:24:01 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393859072; Read time: 244; Write time: 208832 07:24:01 INFO - TinderboxPrint: CPU usage
13.1% 07:24:01 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 244 07:24:01 INFO - TinderboxPrint: I/O write bytes / time
393,859,072 / 208,832 07:24:01 INFO - TinderboxPrint: CPU idle
8,332.0 (86.9%) 07:24:01 INFO - TinderboxPrint: CPU user
1,213.4 (12.6%) 07:24:01 INFO - TinderboxPrint: Swap in / out
0 / 0 07:24:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110501888; Read time: 0; Write time: 56636 07:24:01 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283074560; Read time: 244; Write time: 152172 07:24:02 INFO - Running post-run listener: _upload_blobber_files 07:24:02 INFO - Blob upload gear active. 07:24:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:24:02 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 07:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:24:02 INFO - (blobuploader) - INFO - Open directory for files ... 07:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:03 INFO - (blobuploader) - INFO - Done attempting. 07:24:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:24:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:04 INFO - (blobuploader) - INFO - Done attempting. 07:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:24:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:05 INFO - (blobuploader) - INFO - Done attempting. 07:24:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:24:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:09 INFO - (blobuploader) - INFO - Done attempting. 07:24:09 INFO - (blobuploader) - INFO - Iteration through files over. 07:24:09 INFO - Return code: 0 07:24:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:24:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:24:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7298d0be544a09f843f0d156ab4134323265e6d720f15a69b8cbf3d52a7515519a2bbff9fb0b8e0e6cc51adfc9e6f6a46cff15ce6b4b5c8d43ff54a092b8877d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/081d4e8b680e0115f77b15ea2475c84a6683851575370fc8b9155998873b289dfbeb8637537eb2d97b43ab3c0a387805f42edfd79865f08224774415434fdbf7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a40bbbaf40449b4077eefe6bae6b759b80f57c2fbbb8dbe3c2dec86c1bca173c1bad7896b570380b5f0f1df9382d84cf083723b3fa879cc4fa078e8a8f497437", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d8017846cb0998c29d94f808b894b4048aecc57d2965db1257ae7bac4378709350a56cba28902306b7693e9a3e4eda66fd23e5d530b243403b213084481719e"} 07:24:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:24:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:24:09 INFO - Contents: 07:24:09 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7298d0be544a09f843f0d156ab4134323265e6d720f15a69b8cbf3d52a7515519a2bbff9fb0b8e0e6cc51adfc9e6f6a46cff15ce6b4b5c8d43ff54a092b8877d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/081d4e8b680e0115f77b15ea2475c84a6683851575370fc8b9155998873b289dfbeb8637537eb2d97b43ab3c0a387805f42edfd79865f08224774415434fdbf7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a40bbbaf40449b4077eefe6bae6b759b80f57c2fbbb8dbe3c2dec86c1bca173c1bad7896b570380b5f0f1df9382d84cf083723b3fa879cc4fa078e8a8f497437", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d8017846cb0998c29d94f808b894b4048aecc57d2965db1257ae7bac4378709350a56cba28902306b7693e9a3e4eda66fd23e5d530b243403b213084481719e"} 07:24:09 INFO - Running post-run listener: copy_logs_to_upload_dir 07:24:09 INFO - Copying logs to upload dir... 07:24:09 INFO - mkdir: /builds/slave/test/build/upload/logs 07:24:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.015280 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-04 07:24:09.446361) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 07:24:09.449845) ========= 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-1483541456.970436-1370129953 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-Non-PGO/sha512/7298d0be544a09f843f0d156ab4134323265e6d720f15a69b8cbf3d52a7515519a2bbff9fb0b8e0e6cc51adfc9e6f6a46cff15ce6b4b5c8d43ff54a092b8877d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/081d4e8b680e0115f77b15ea2475c84a6683851575370fc8b9155998873b289dfbeb8637537eb2d97b43ab3c0a387805f42edfd79865f08224774415434fdbf7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a40bbbaf40449b4077eefe6bae6b759b80f57c2fbbb8dbe3c2dec86c1bca173c1bad7896b570380b5f0f1df9382d84cf083723b3fa879cc4fa078e8a8f497437", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d8017846cb0998c29d94f808b894b4048aecc57d2965db1257ae7bac4378709350a56cba28902306b7693e9a3e4eda66fd23e5d530b243403b213084481719e"} build_url:https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7298d0be544a09f843f0d156ab4134323265e6d720f15a69b8cbf3d52a7515519a2bbff9fb0b8e0e6cc51adfc9e6f6a46cff15ce6b4b5c8d43ff54a092b8877d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/081d4e8b680e0115f77b15ea2475c84a6683851575370fc8b9155998873b289dfbeb8637537eb2d97b43ab3c0a387805f42edfd79865f08224774415434fdbf7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a40bbbaf40449b4077eefe6bae6b759b80f57c2fbbb8dbe3c2dec86c1bca173c1bad7896b570380b5f0f1df9382d84cf083723b3fa879cc4fa078e8a8f497437", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d8017846cb0998c29d94f808b894b4048aecc57d2965db1257ae7bac4378709350a56cba28902306b7693e9a3e4eda66fd23e5d530b243403b213084481719e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 07:24:09.477380) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:24:09.477865) ========= 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-1483541456.970436-1370129953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:24:09.560190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 07:24:09.560658) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 07:24:09.561088) ========= ========= Total master_lag: 0.18 =========