builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1483585207.06 results: success (0) revision: 1bf65dbb4d71ccc02ad63b95a039112073d83e5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:07.056024) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:07.056521) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:07.056802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:07.072872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:07.073265) ========= 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=52faae308a556c440401f8e5000001e8-1483582836.869440-988595144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-04 19:00:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-01-04 19:00:07 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120002 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:07.207025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:07.207343) ========= 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=52faae308a556c440401f8e5000001e8-1483582836.869440-988595144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018087 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:07.263600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 19:00:07.264089) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1bf65dbb4d71ccc02ad63b95a039112073d83e5e --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 1bf65dbb4d71ccc02ad63b95a039112073d83e5e --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=52faae308a556c440401f8e5000001e8-1483582836.869440-988595144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-04 19:00:07,494 truncating revision to first 12 chars 2017-01-04 19:00:07,494 Setting DEBUG logging. 2017-01-04 19:00:07,494 attempt 1/10 2017-01-04 19:00:07,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1bf65dbb4d71?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 19:00:08,503 unpacking tar archive at: mozilla-central-1bf65dbb4d71/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323655 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 19:00:08.601672) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:08.602063) ========= script_repo_revision: 1bf65dbb4d71ccc02ad63b95a039112073d83e5e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:08.602508) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:08.602785) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 19:00:08.614287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-04 19:00:08.614927) ========= /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=52faae308a556c440401f8e5000001e8-1483582836.869440-988595144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:00:08 INFO - MultiFileLogger online at 20170104 19:00:08 in /builds/slave/test 19:00:08 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 19:00:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:00:08 INFO - {'append_to_log': False, 19:00:08 INFO - 'base_work_dir': '/builds/slave/test', 19:00:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:00:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:00:08 INFO - 'branch': 'Firefox-Non-PGO', 19:00:08 INFO - 'buildbot_json_path': 'buildprops.json', 19:00:08 INFO - 'config_files': ('talos/linux_config.py',), 19:00:08 INFO - 'default_actions': ('clobber', 19:00:08 INFO - 'read-buildbot-config', 19:00:08 INFO - 'download-and-extract', 19:00:08 INFO - 'populate-webroot', 19:00:08 INFO - 'create-virtualenv', 19:00:08 INFO - 'install', 19:00:08 INFO - 'run-tests'), 19:00:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:00:08 INFO - 'download_minidump_stackwalk': True, 19:00:08 INFO - 'download_symbols': 'ondemand', 19:00:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:00:08 INFO - 'tooltool.py': '/tools/tooltool.py', 19:00:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:00:08 INFO - '/tools/misc-python/virtualenv.py')}, 19:00:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:00:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:00:08 INFO - 'installer_path': 'installer.exe', 19:00:08 INFO - 'log_level': 'info', 19:00:08 INFO - 'log_name': 'talos', 19:00:08 INFO - 'log_to_console': True, 19:00:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:00:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:00:08 INFO - 'opt_config_files': (), 19:00:08 INFO - 'pip_index': False, 19:00:08 INFO - 'sps_profile': False, 19:00:08 INFO - 'sps_profile_interval': 0, 19:00:08 INFO - 'suite': 'dromaeojs', 19:00:08 INFO - 'system_bits': '32', 19:00:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:00:08 INFO - 'title': 'talos-linux64-ix-056', 19:00:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:00:08 INFO - 'use_talos_json': True, 19:00:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:00:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:00:08 INFO - 'work_dir': 'build'} 19:00:08 INFO - [mozharness: 2017-01-05 03:00:08.948737Z] Running clobber step. 19:00:08 INFO - Running pre-action listener: _resource_record_pre_action 19:00:08 INFO - Running main action method: clobber 19:00:08 INFO - rmtree: /builds/slave/test/build 19:00:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:00:09 INFO - Running post-action listener: _resource_record_post_action 19:00:09 INFO - [mozharness: 2017-01-05 03:00:09.415879Z] Finished clobber step (success) 19:00:09 INFO - [mozharness: 2017-01-05 03:00:09.415980Z] Running read-buildbot-config step. 19:00:09 INFO - Running pre-action listener: _resource_record_pre_action 19:00:09 INFO - Running main action method: read_buildbot_config 19:00:09 INFO - Using buildbot properties: 19:00:09 INFO - { 19:00:09 INFO - "project": "", 19:00:09 INFO - "product": "firefox", 19:00:09 INFO - "who": "philringnalda@gmail.com", 19:00:09 INFO - "installer_path": "public/build/target.tar.bz2", 19:00:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:00:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:00:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 19:00:09 INFO - "stage_platform": "linux64", 19:00:09 INFO - "basedir": "/builds/slave/test", 19:00:09 INFO - "buildnumber": 899, 19:00:09 INFO - "platform": "ubuntu64_hw", 19:00:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:00:09 INFO - "slavebuilddir": "test", 19:00:09 INFO - "taskId": "NnErKY4pQLqrKTFTwIzBDw", 19:00:09 INFO - "branch": "mozilla-central", 19:00:09 INFO - "script_repo_revision": "production", 19:00:09 INFO - "revision": "1bf65dbb4d71ccc02ad63b95a039112073d83e5e", 19:00:09 INFO - "slavename": "talos-linux64-ix-056", 19:00:09 INFO - "repo_path": "mozilla-central" 19:00:09 INFO - } 19:00:09 INFO - Finding installer, test and symbols from parent task. 19:00:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NnErKY4pQLqrKTFTwIzBDw'}, attempt #1 19:00:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NnErKY4pQLqrKTFTwIzBDw'}, attempt #1 19:00:10 INFO - Task dependencies: OASrlaYCTQqM0wWf-2A0cQ 19:00:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ'}, attempt #1 19:00:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.tar.bz2 19:00:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/test_packages.json 19:00:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.crashreporter-symbols.zip 19:00:10 INFO - Running post-action listener: _resource_record_post_action 19:00:10 INFO - [mozharness: 2017-01-05 03:00:10.812980Z] Finished read-buildbot-config step (success) 19:00:10 INFO - [mozharness: 2017-01-05 03:00:10.813242Z] Running download-and-extract step. 19:00:10 INFO - Running pre-action listener: _resource_record_pre_action 19:00:10 INFO - Running main action method: download_and_extract 19:00:10 INFO - mkdir: /builds/slave/test/build/tests 19:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:10 INFO - trying https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.test_packages.json 19:00:10 INFO - Downloading https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:00:11 INFO - Downloaded 896 bytes. 19:00:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:00:11 INFO - Using the following test package requirements: 19:00:11 INFO - {u'common': [u'target.common.tests.zip'], 19:00:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:00:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:00:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:00:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:00:11 INFO - u'mozbase': [u'target.common.tests.zip'], 19:00:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:00:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:00:11 INFO - u'web-platform': [u'target.common.tests.zip', 19:00:11 INFO - u'target.web-platform.tests.zip'], 19:00:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:00:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:00:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.common.tests.zip 19:00:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:00:11 INFO - Fetch https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.common.tests.zip into memory 19:00:12 INFO - Expected file size: 20244966 19:00:12 INFO - Obtained file size: 20244966 19:00:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:00:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.common.tests.zip 19:00:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:00:16 INFO - Fetch https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.common.tests.zip into memory 19:00:17 INFO - Expected file size: 20244966 19:00:17 INFO - Obtained file size: 20244966 19:00:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.talos.tests.zip 19:00:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:00:21 INFO - Fetch https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.talos.tests.zip into memory 19:00:22 INFO - Expected file size: 14403730 19:00:22 INFO - Obtained file size: 14403730 19:00:22 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')]} 19:00:22 INFO - trying https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.tar.bz2 19:00:22 INFO - Downloading https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:00:23 INFO - Downloaded 55925113 bytes. 19:00:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.tar.bz2 19:00:23 INFO - mkdir: /builds/slave/test/properties 19:00:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:00:23 INFO - Writing to file /builds/slave/test/properties/build_url 19:00:23 INFO - Contents: 19:00:23 INFO - build_url:https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.tar.bz2 19:00:23 INFO - Running post-action listener: _resource_record_post_action 19:00:23 INFO - Running post-action listener: set_extra_try_arguments 19:00:23 INFO - [mozharness: 2017-01-05 03:00:23.752177Z] Finished download-and-extract step (success) 19:00:23 INFO - [mozharness: 2017-01-05 03:00:23.752273Z] Running populate-webroot step. 19:00:23 INFO - Running pre-action listener: _resource_record_pre_action 19:00:23 INFO - Running main action method: populate_webroot 19:00:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:23 INFO - '--tppagecycles', 19:00:23 INFO - '7'], 19:00:23 INFO - 'tests': ['tsvgm']}}, 19:00:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:00:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:00:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:00:23 INFO - 'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:00:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:00:23 INFO - 'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['damp', 'tps']}, 19:00:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:00:23 INFO - 'tests': ['damp', 'tps']}, 19:00:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['dromaeo_dom']}, 19:00:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['basic_compositor_video']}, 19:00:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:00:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['a11yr', 19:00:23 INFO - 'ts_paint', 19:00:23 INFO - 'tpaint', 19:00:23 INFO - 'sessionrestore', 19:00:23 INFO - 'sessionrestore_no_auto_restore', 19:00:23 INFO - 'tabpaint']}, 19:00:23 INFO - 'other-e10s': {'tests': ['a11yr', 19:00:23 INFO - 'ts_paint', 19:00:23 INFO - 'tpaint', 19:00:23 INFO - 'sessionrestore', 19:00:23 INFO - 'sessionrestore_no_auto_restore', 19:00:23 INFO - 'tabpaint']}, 19:00:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:00:23 INFO - 'ts_paint', 19:00:23 INFO - 'tpaint', 19:00:23 INFO - 'sessionrestore', 19:00:23 INFO - 'sessionrestore_no_auto_restore', 19:00:23 INFO - 'tabpaint']}, 19:00:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:00:23 INFO - 'ts_paint', 19:00:23 INFO - 'tpaint', 19:00:23 INFO - 'sessionrestore', 19:00:23 INFO - 'sessionrestore_no_auto_restore', 19:00:23 INFO - 'tabpaint']}, 19:00:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['a11yr', 19:00:23 INFO - 'ts_paint', 19:00:23 INFO - 'tpaint', 19:00:23 INFO - 'sessionrestore', 19:00:23 INFO - 'sessionrestore_no_auto_restore', 19:00:23 INFO - 'tabpaint']}, 19:00:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['a11yr', 19:00:23 INFO - 'ts_paint', 19:00:23 INFO - 'tpaint', 19:00:23 INFO - 'sessionrestore', 19:00:23 INFO - 'sessionrestore_no_auto_restore', 19:00:23 INFO - 'tabpaint']}, 19:00:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['tsvgx', 19:00:23 INFO - 'tsvgr_opacity', 19:00:23 INFO - 'tart', 19:00:23 INFO - 'tscrollx', 19:00:23 INFO - 'cart', 19:00:23 INFO - 'tsvg_static']}, 19:00:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:00:23 INFO - 'tsvgr_opacity', 19:00:23 INFO - 'tart', 19:00:23 INFO - 'tscrollx', 19:00:23 INFO - 'cart', 19:00:23 INFO - 'tsvg_static']}, 19:00:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:00:23 INFO - 'talos_options': ['--disable-e10s'], 19:00:23 INFO - 'tests': ['tp5o']}, 19:00:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:00:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:00:23 INFO - 'talos_options': ['--disable-e10s', 19:00:23 INFO - '--xperf_path', 19:00:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:23 INFO - 'tests': ['tp5n']}, 19:00:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:00:23 INFO - 'talos_options': ['--xperf_path', 19:00:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:23 INFO - 'tests': ['tp5n']}}, 19:00:23 INFO - 'talos.zip': {'path': '', 19:00:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:23 INFO - Running post-action listener: _resource_record_post_action 19:00:23 INFO - [mozharness: 2017-01-05 03:00:23.765352Z] Finished populate-webroot step (success) 19:00:23 INFO - [mozharness: 2017-01-05 03:00:23.765445Z] Running create-virtualenv step. 19:00:23 INFO - Running pre-action listener: _resource_record_pre_action 19:00:23 INFO - Running main action method: create_virtualenv 19:00:23 INFO - Creating virtualenv /builds/slave/test/build/venv 19:00:23 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 19:00:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:00:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:23 INFO - Using real prefix '/usr' 19:00:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:00:24 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:26 INFO - Installing pip.................done. 19:00:26 INFO - Return code: 0 19:00:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:00:26 INFO - Reading from file tmpfile_stdout 19:00:26 INFO - Output received: 19:00:26 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) 19:00:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00:26 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')]} 19:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:26 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')]} 19:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:26 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 0x285c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, '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': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', '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 19:00:26 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 19:00:26 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 19:00:26 INFO - Using env: {'DISPLAY': ':0', 19:00:26 INFO - 'HOME': '/home/cltbld', 19:00:26 INFO - 'LANG': 'en_US.UTF-8', 19:00:26 INFO - 'LANGUAGE': 'en_US:en', 19:00:26 INFO - 'LOGNAME': 'cltbld', 19:00:26 INFO - 'MAIL': '/var/mail/cltbld', 19:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:26 INFO - 'MOZ_NO_REMOTE': '1', 19:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:26 INFO - 'NO_EM_RESTART': '1', 19:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:26 INFO - 'PWD': '/builds/slave/test', 19:00:26 INFO - 'SHELL': '/bin/bash', 19:00:26 INFO - 'SHLVL': '1', 19:00:26 INFO - 'TERM': 'linux', 19:00:26 INFO - 'TMOUT': '86400', 19:00:26 INFO - 'USER': 'cltbld', 19:00:26 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:26 INFO - '_': '/tools/buildbot/bin/python'} 19:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:26 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 19:00:26 INFO - Cleaning up... 19:00:26 INFO - Return code: 0 19:00:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:00:26 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')]} 19:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:26 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')]} 19:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:26 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 0x285c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, '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': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', '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 19:00:26 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 19:00:26 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 19:00:26 INFO - Using env: {'DISPLAY': ':0', 19:00:26 INFO - 'HOME': '/home/cltbld', 19:00:26 INFO - 'LANG': 'en_US.UTF-8', 19:00:26 INFO - 'LANGUAGE': 'en_US:en', 19:00:26 INFO - 'LOGNAME': 'cltbld', 19:00:26 INFO - 'MAIL': '/var/mail/cltbld', 19:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:26 INFO - 'MOZ_NO_REMOTE': '1', 19:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:26 INFO - 'NO_EM_RESTART': '1', 19:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:26 INFO - 'PWD': '/builds/slave/test', 19:00:26 INFO - 'SHELL': '/bin/bash', 19:00:26 INFO - 'SHLVL': '1', 19:00:26 INFO - 'TERM': 'linux', 19:00:26 INFO - 'TMOUT': '86400', 19:00:26 INFO - 'USER': 'cltbld', 19:00:26 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:26 INFO - '_': '/tools/buildbot/bin/python'} 19:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:26 INFO - Downloading/unpacking psutil>=3.1.1 19:00:26 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 19:00:26 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 19:00:26 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 19:00:27 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 19:00:27 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 19:00:27 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 19:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:29 INFO - Installing collected packages: psutil 19:00:29 INFO - Running setup.py install for psutil 19:00:29 INFO - building 'psutil._psutil_linux' extension 19:00:29 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 19:00:29 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 19:00:29 INFO - building 'psutil._psutil_posix' extension 19:00:29 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 19:00:29 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 19:00:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:29 INFO - Successfully installed psutil 19:00:29 INFO - Cleaning up... 19:00:29 INFO - Return code: 0 19:00:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:29 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 0x285c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, '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': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', '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 19:00:29 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 19:00:29 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 19:00:29 INFO - Using env: {'DISPLAY': ':0', 19:00:29 INFO - 'HOME': '/home/cltbld', 19:00:29 INFO - 'LANG': 'en_US.UTF-8', 19:00:29 INFO - 'LANGUAGE': 'en_US:en', 19:00:29 INFO - 'LOGNAME': 'cltbld', 19:00:29 INFO - 'MAIL': '/var/mail/cltbld', 19:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:29 INFO - 'MOZ_NO_REMOTE': '1', 19:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:29 INFO - 'NO_EM_RESTART': '1', 19:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:29 INFO - 'PWD': '/builds/slave/test', 19:00:29 INFO - 'SHELL': '/bin/bash', 19:00:29 INFO - 'SHLVL': '1', 19:00:29 INFO - 'TERM': 'linux', 19:00:29 INFO - 'TMOUT': '86400', 19:00:29 INFO - 'USER': 'cltbld', 19:00:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:29 INFO - '_': '/tools/buildbot/bin/python'} 19:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:00:29 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 19:00:29 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 19:00:29 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 19:00:29 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 19:00:29 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 19:00:29 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 19:00:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:00:31 INFO - Installing collected packages: mozsystemmonitor 19:00:31 INFO - Running setup.py install for mozsystemmonitor 19:00:32 INFO - Successfully installed mozsystemmonitor 19:00:32 INFO - Cleaning up... 19:00:32 INFO - Return code: 0 19:00:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:00:32 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')]} 19:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:32 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')]} 19:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:32 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 0x285c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, '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': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', '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 19:00:32 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 19:00:32 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 19:00:32 INFO - Using env: {'DISPLAY': ':0', 19:00:32 INFO - 'HOME': '/home/cltbld', 19:00:32 INFO - 'LANG': 'en_US.UTF-8', 19:00:32 INFO - 'LANGUAGE': 'en_US:en', 19:00:32 INFO - 'LOGNAME': 'cltbld', 19:00:32 INFO - 'MAIL': '/var/mail/cltbld', 19:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:32 INFO - 'MOZ_NO_REMOTE': '1', 19:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:32 INFO - 'NO_EM_RESTART': '1', 19:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:32 INFO - 'PWD': '/builds/slave/test', 19:00:32 INFO - 'SHELL': '/bin/bash', 19:00:32 INFO - 'SHLVL': '1', 19:00:32 INFO - 'TERM': 'linux', 19:00:32 INFO - 'TMOUT': '86400', 19:00:32 INFO - 'USER': 'cltbld', 19:00:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:32 INFO - '_': '/tools/buildbot/bin/python'} 19:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:32 INFO - Downloading/unpacking jsonschema==2.5.1 19:00:32 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 19:00:32 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 19:00:32 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 19:00:32 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 19:00:32 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 19:00:32 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 19:00:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:00:34 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 19:00:34 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 19:00:34 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 19:00:34 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 19:00:34 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 19:00:34 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 19:00:34 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:34 INFO - warning: no files found matching '*.txt' 19:00:34 INFO - no previously-included directories found matching 'build' 19:00:34 INFO - no previously-included directories found matching 'dist' 19:00:34 INFO - no previously-included directories found matching '.git*' 19:00:34 INFO - Installing collected packages: jsonschema, functools32 19:00:34 INFO - Running setup.py install for functools32 19:00:34 INFO - warning: no files found matching '*.txt' 19:00:34 INFO - no previously-included directories found matching 'build' 19:00:34 INFO - no previously-included directories found matching 'dist' 19:00:34 INFO - no previously-included directories found matching '.git*' 19:00:34 INFO - Successfully installed jsonschema functools32 19:00:34 INFO - Cleaning up... 19:00:34 INFO - Return code: 0 19:00:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:34 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 0x285c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, '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': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', '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 19:00:34 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 19:00:34 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 19:00:34 INFO - Using env: {'DISPLAY': ':0', 19:00:34 INFO - 'HOME': '/home/cltbld', 19:00:34 INFO - 'LANG': 'en_US.UTF-8', 19:00:34 INFO - 'LANGUAGE': 'en_US:en', 19:00:34 INFO - 'LOGNAME': 'cltbld', 19:00:34 INFO - 'MAIL': '/var/mail/cltbld', 19:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:34 INFO - 'MOZ_NO_REMOTE': '1', 19:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:34 INFO - 'NO_EM_RESTART': '1', 19:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:34 INFO - 'PWD': '/builds/slave/test', 19:00:34 INFO - 'SHELL': '/bin/bash', 19:00:34 INFO - 'SHLVL': '1', 19:00:34 INFO - 'TERM': 'linux', 19:00:34 INFO - 'TMOUT': '86400', 19:00:34 INFO - 'USER': 'cltbld', 19:00:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:34 INFO - '_': '/tools/buildbot/bin/python'} 19:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:00:35 INFO - Cleaning up... 19:00:35 INFO - Return code: 0 19:00:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:35 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 0x285c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, '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': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', '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 19:00:35 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 19:00:35 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 19:00:35 INFO - Using env: {'DISPLAY': ':0', 19:00:35 INFO - 'HOME': '/home/cltbld', 19:00:35 INFO - 'LANG': 'en_US.UTF-8', 19:00:35 INFO - 'LANGUAGE': 'en_US:en', 19:00:35 INFO - 'LOGNAME': 'cltbld', 19:00:35 INFO - 'MAIL': '/var/mail/cltbld', 19:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:35 INFO - 'MOZ_NO_REMOTE': '1', 19:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:35 INFO - 'NO_EM_RESTART': '1', 19:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:35 INFO - 'PWD': '/builds/slave/test', 19:00:35 INFO - 'SHELL': '/bin/bash', 19:00:35 INFO - 'SHLVL': '1', 19:00:35 INFO - 'TERM': 'linux', 19:00:35 INFO - 'TMOUT': '86400', 19:00:35 INFO - 'USER': 'cltbld', 19:00:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:35 INFO - '_': '/tools/buildbot/bin/python'} 19:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:35 INFO - Downloading/unpacking blobuploader==1.2.4 19:00:35 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 19:00:35 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 19:00:35 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 19:00:35 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 19:00:35 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 19:00:35 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 19:00:37 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00:37 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 19:00:37 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 19:00:37 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 19:00:37 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 19:00:37 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 19:00:37 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 19:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:00:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00:37 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 19:00:37 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 19:00:37 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 19:00:37 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 19:00:37 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 19:00:37 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 19:00:37 INFO - Downloading docopt-0.6.1.tar.gz 19:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:38 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:38 INFO - Running setup.py install for blobuploader 19:00:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:38 INFO - Running setup.py install for requests 19:00:38 INFO - Running setup.py install for docopt 19:00:38 INFO - Successfully installed blobuploader requests docopt 19:00:38 INFO - Cleaning up... 19:00:38 INFO - Return code: 0 19:00:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:38 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')]} 19:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:38 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')]} 19:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:38 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 0x285c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, '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': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', '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 19:00:38 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 19:00:38 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 19:00:38 INFO - Using env: {'DISPLAY': ':0', 19:00:38 INFO - 'HOME': '/home/cltbld', 19:00:38 INFO - 'LANG': 'en_US.UTF-8', 19:00:38 INFO - 'LANGUAGE': 'en_US:en', 19:00:38 INFO - 'LOGNAME': 'cltbld', 19:00:38 INFO - 'MAIL': '/var/mail/cltbld', 19:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:38 INFO - 'MOZ_NO_REMOTE': '1', 19:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:38 INFO - 'NO_EM_RESTART': '1', 19:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:38 INFO - 'PWD': '/builds/slave/test', 19:00:38 INFO - 'SHELL': '/bin/bash', 19:00:38 INFO - 'SHLVL': '1', 19:00:38 INFO - 'TERM': 'linux', 19:00:38 INFO - 'TMOUT': '86400', 19:00:38 INFO - 'USER': 'cltbld', 19:00:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:38 INFO - '_': '/tools/buildbot/bin/python'} 19:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:38 INFO - Running setup.py (path:/tmp/pip-bkf8qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:38 INFO - Running setup.py (path:/tmp/pip-zEDYwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:39 INFO - Running setup.py (path:/tmp/pip-cCFQGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:39 INFO - Running setup.py (path:/tmp/pip-0KnMlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:39 INFO - Running setup.py (path:/tmp/pip-1o_bDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:39 INFO - Running setup.py (path:/tmp/pip-NRNkDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:39 INFO - Running setup.py (path:/tmp/pip-W1HTMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:39 INFO - Running setup.py (path:/tmp/pip-tNgOnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:39 INFO - Running setup.py (path:/tmp/pip-qGSXy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:39 INFO - Running setup.py (path:/tmp/pip-h0oVOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:39 INFO - Running setup.py (path:/tmp/pip-xNUFzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:39 INFO - Running setup.py (path:/tmp/pip-FDUkpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:39 INFO - Running setup.py (path:/tmp/pip-2TZAU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:39 INFO - Running setup.py (path:/tmp/pip-7TSiWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:39 INFO - Running setup.py (path:/tmp/pip-lI0mQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:40 INFO - Running setup.py (path:/tmp/pip-hNqFqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:40 INFO - Running setup.py (path:/tmp/pip-fbwWD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:40 INFO - Running setup.py install for manifestparser 19:00:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:40 INFO - Running setup.py install for mozcrash 19:00:40 INFO - Running setup.py install for mozdebug 19:00:40 INFO - Running setup.py install for mozdevice 19:00:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:00:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:00:40 INFO - Running setup.py install for mozfile 19:00:40 INFO - Running setup.py install for mozhttpd 19:00:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:00:40 INFO - Running setup.py install for mozinfo 19:00:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:00:40 INFO - Running setup.py install for mozInstall 19:00:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:00:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:00:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:00:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:00:40 INFO - Running setup.py install for mozleak 19:00:41 INFO - Running setup.py install for mozlog 19:00:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for moznetwork 19:00:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozprocess 19:00:41 INFO - Running setup.py install for mozprofile 19:00:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozrunner 19:00:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozscreenshot 19:00:41 INFO - Running setup.py install for moztest 19:00:41 INFO - Running setup.py install for mozversion 19:00:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:41 INFO - Cleaning up... 19:00:41 INFO - Return code: 0 19:00:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:41 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 0x285c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, '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': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', '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 19:00:41 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 19:00:41 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 19:00:41 INFO - Using env: {'DISPLAY': ':0', 19:00:41 INFO - 'HOME': '/home/cltbld', 19:00:41 INFO - 'LANG': 'en_US.UTF-8', 19:00:41 INFO - 'LANGUAGE': 'en_US:en', 19:00:41 INFO - 'LOGNAME': 'cltbld', 19:00:41 INFO - 'MAIL': '/var/mail/cltbld', 19:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:41 INFO - 'MOZ_NO_REMOTE': '1', 19:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:41 INFO - 'NO_EM_RESTART': '1', 19:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:41 INFO - 'PWD': '/builds/slave/test', 19:00:41 INFO - 'SHELL': '/bin/bash', 19:00:41 INFO - 'SHLVL': '1', 19:00:41 INFO - 'TERM': 'linux', 19:00:41 INFO - 'TMOUT': '86400', 19:00:41 INFO - 'USER': 'cltbld', 19:00:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:41 INFO - '_': '/tools/buildbot/bin/python'} 19:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:42 INFO - Running setup.py (path:/tmp/pip-kMjOoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:42 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)) 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:42 INFO - Running setup.py (path:/tmp/pip-sQjVv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:42 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)) 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:42 INFO - Running setup.py (path:/tmp/pip-osECZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:42 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)) 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:42 INFO - Running setup.py (path:/tmp/pip-BnPeh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:42 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)) 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:42 INFO - Running setup.py (path:/tmp/pip-eAZpwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:42 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)) 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:42 INFO - Running setup.py (path:/tmp/pip-bGDY5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:42 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)) 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:42 INFO - Running setup.py (path:/tmp/pip-Ku4S7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:42 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)) 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:42 INFO - Running setup.py (path:/tmp/pip-3ftkJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:42 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)) 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:42 INFO - Running setup.py (path:/tmp/pip-FOnXG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:42 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)) 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:42 INFO - Running setup.py (path:/tmp/pip-H6CtH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:42 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)) 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:42 INFO - Running setup.py (path:/tmp/pip-6hMR6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:43 INFO - Running setup.py (path:/tmp/pip-x015w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:43 INFO - Running setup.py (path:/tmp/pip-U5tlL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:43 INFO - Running setup.py (path:/tmp/pip-VHR1UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:43 INFO - Running setup.py (path:/tmp/pip-LaYKx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:43 INFO - Running setup.py (path:/tmp/pip-giLQA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:43 INFO - Running setup.py (path:/tmp/pip-18KQaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:43 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)) 19:00:43 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)) 19:00:43 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)) 19:00:43 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)) 19:00:43 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)) 19:00:43 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)) 19:00:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:43 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 19:00:43 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 19:00:43 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 19:00:43 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 19:00:43 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 19:00:43 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 19:00:45 INFO - Downloading blessings-1.6.tar.gz 19:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:45 INFO - Installing collected packages: blessings 19:00:45 INFO - Running setup.py install for blessings 19:00:45 INFO - Successfully installed blessings 19:00:45 INFO - Cleaning up... 19:00:45 INFO - Return code: 0 19:00:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:45 INFO - Reading from file tmpfile_stdout 19:00:45 INFO - Current package versions: 19:00:45 INFO - argparse == 1.2.1 19:00:45 INFO - blessings == 1.6 19:00:45 INFO - blobuploader == 1.2.4 19:00:45 INFO - docopt == 0.6.1 19:00:45 INFO - functools32 == 3.2.3-2 19:00:45 INFO - jsonschema == 2.5.1 19:00:45 INFO - manifestparser == 1.1 19:00:45 INFO - mozInstall == 1.12 19:00:45 INFO - mozcrash == 1.0 19:00:45 INFO - mozdebug == 0.1 19:00:45 INFO - mozdevice == 0.49 19:00:45 INFO - mozfile == 1.2 19:00:45 INFO - mozhttpd == 0.7 19:00:45 INFO - mozinfo == 0.9 19:00:45 INFO - mozleak == 0.1 19:00:45 INFO - mozlog == 3.4 19:00:45 INFO - moznetwork == 0.27 19:00:45 INFO - mozprocess == 0.23 19:00:45 INFO - mozprofile == 0.28 19:00:45 INFO - mozrunner == 6.13 19:00:45 INFO - mozscreenshot == 0.1 19:00:45 INFO - mozsystemmonitor == 0.3 19:00:45 INFO - moztest == 0.8 19:00:45 INFO - mozversion == 1.4 19:00:45 INFO - psutil == 3.1.1 19:00:45 INFO - requests == 1.2.3 19:00:45 INFO - wsgiref == 0.1.2 19:00:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:45 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 0x285c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, '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': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', '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 19:00:45 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 19:00:45 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 19:00:45 INFO - Using env: {'DISPLAY': ':0', 19:00:45 INFO - 'HOME': '/home/cltbld', 19:00:45 INFO - 'LANG': 'en_US.UTF-8', 19:00:45 INFO - 'LANGUAGE': 'en_US:en', 19:00:45 INFO - 'LOGNAME': 'cltbld', 19:00:45 INFO - 'MAIL': '/var/mail/cltbld', 19:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:45 INFO - 'MOZ_NO_REMOTE': '1', 19:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:45 INFO - 'NO_EM_RESTART': '1', 19:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:45 INFO - 'PWD': '/builds/slave/test', 19:00:45 INFO - 'SHELL': '/bin/bash', 19:00:45 INFO - 'SHLVL': '1', 19:00:45 INFO - 'TERM': 'linux', 19:00:45 INFO - 'TMOUT': '86400', 19:00:45 INFO - 'USER': 'cltbld', 19:00:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:45 INFO - '_': '/tools/buildbot/bin/python'} 19:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 INFO - Cleaning up... 19:00:46 INFO - Return code: 0 19:00:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, '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': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', '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 19:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:00:46 INFO - Using env: {'DISPLAY': ':0', 19:00:46 INFO - 'HOME': '/home/cltbld', 19:00:46 INFO - 'LANG': 'en_US.UTF-8', 19:00:46 INFO - 'LANGUAGE': 'en_US:en', 19:00:46 INFO - 'LOGNAME': 'cltbld', 19:00:46 INFO - 'MAIL': '/var/mail/cltbld', 19:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:46 INFO - 'MOZ_NO_REMOTE': '1', 19:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:46 INFO - 'NO_EM_RESTART': '1', 19:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:46 INFO - 'PWD': '/builds/slave/test', 19:00:46 INFO - 'SHELL': '/bin/bash', 19:00:46 INFO - 'SHLVL': '1', 19:00:46 INFO - 'TERM': 'linux', 19:00:46 INFO - 'TMOUT': '86400', 19:00:46 INFO - 'USER': 'cltbld', 19:00:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:46 INFO - '_': '/tools/buildbot/bin/python'} 19:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:00:46 INFO - Cleaning up... 19:00:46 INFO - Return code: 0 19:00:46 INFO - Running post-action listener: _resource_record_post_action 19:00:46 INFO - Running post-action listener: _start_resource_monitoring 19:00:46 INFO - Starting resource monitoring. 19:00:46 INFO - [mozharness: 2017-01-05 03:00:46.435210Z] Finished create-virtualenv step (success) 19:00:46 INFO - [mozharness: 2017-01-05 03:00:46.435671Z] Running install step. 19:00:46 INFO - Running pre-action listener: _resource_record_pre_action 19:00:46 INFO - Running main action method: install 19:00:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:46 INFO - Reading from file tmpfile_stdout 19:00:46 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:46 INFO - Reading from file tmpfile_stdout 19:00:46 INFO - Output received: 19:00:46 INFO - Usage: mozinstall [options] installer 19:00:46 INFO - Options: 19:00:46 INFO - -h, --help show this help message and exit 19:00:46 INFO - -d DEST, --destination=DEST 19:00:46 INFO - Directory to install application into. [default: 19:00:46 INFO - "/builds/slave/test"] 19:00:46 INFO - --app=APP Application being installed. [default: firefox] 19:00:46 INFO - mkdir: /builds/slave/test/build/application 19:00:46 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'] 19:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:01:02 INFO - Reading from file tmpfile_stdout 19:01:02 INFO - Output received: 19:01:02 INFO - /builds/slave/test/build/application/firefox/firefox 19:01:02 INFO - Running post-action listener: _resource_record_post_action 19:01:02 INFO - [mozharness: 2017-01-05 03:01:02.872522Z] Finished install step (success) 19:01:02 INFO - [mozharness: 2017-01-05 03:01:02.872801Z] Running run-tests step. 19:01:02 INFO - Running pre-action listener: _resource_record_pre_action 19:01:02 INFO - Running main action method: run_tests 19:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:01:02 INFO - Python 2.7.3 19:01:02 INFO - Return code: 0 19:01:02 INFO - grabbing minidump binary from tooltool 19:01:02 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')]} 19:01:02 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 0x2c57850>, '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 0x2bcc6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bccb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:01:02 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 19:01:02 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 19:01:02 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 19:01:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:01:02 INFO - Return code: 0 19:01:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:01:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:01:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:01:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:01:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:01:02 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/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 19:01:02 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/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 19:01:02 INFO - Using env: {'DISPLAY': ':0', 19:01:02 INFO - 'HOME': '/home/cltbld', 19:01:02 INFO - 'LANG': 'en_US.UTF-8', 19:01:02 INFO - 'LANGUAGE': 'en_US:en', 19:01:02 INFO - 'LOGNAME': 'cltbld', 19:01:02 INFO - 'MAIL': '/var/mail/cltbld', 19:01:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:01:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:02 INFO - 'MOZ_NO_REMOTE': '1', 19:01:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:02 INFO - 'NO_EM_RESTART': '1', 19:01:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:02 INFO - 'PWD': '/builds/slave/test', 19:01:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:01:02 INFO - 'SHELL': '/bin/bash', 19:01:02 INFO - 'SHLVL': '1', 19:01:02 INFO - 'TERM': 'linux', 19:01:02 INFO - 'TMOUT': '86400', 19:01:02 INFO - 'USER': 'cltbld', 19:01:02 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1483582836.869440-988595144', 19:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:02 INFO - '_': '/tools/buildbot/bin/python'} 19:01:02 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/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 19:01:03 INFO - mozversion application_buildid: 20170105022927 19:01:03 INFO - mozversion application_changeset: 1bf65dbb4d71ccc02ad63b95a039112073d83e5e 19:01:03 INFO - mozversion application_display_name: Nightly 19:01:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:01:03 INFO - mozversion application_name: Firefox 19:01:03 INFO - mozversion application_remotingname: firefox 19:01:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:01:03 INFO - mozversion application_vendor: Mozilla 19:01:03 INFO - mozversion application_version: 53.0a1 19:01:03 INFO - mozversion platform_buildid: 20170105022927 19:01:03 INFO - mozversion platform_changeset: 1bf65dbb4d71ccc02ad63b95a039112073d83e5e 19:01:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:01:03 INFO - mozversion platform_version: 53.0a1 19:01:03 INFO - using testdate: 1483585263 19:01:03 INFO - actual date: 1483585263 19:01:03 INFO - starting webserver on 'localhost:33951' 19:01:03 INFO - SUITE-START | Running 2 tests 19:01:03 INFO - TEST-START | dromaeo_css 19:01:03 INFO - operating with platform_type : linux_ 19:01:03 INFO - Initialising browser for dromaeo_css test... 19:01:03 INFO - TEST-INFO | started process 13569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebQKDl/profile http://localhost:33951/getInfo.html) 19:01:03 INFO - PROCESS | 13569 | 1483585263640 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:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 19:01:07 INFO - PROCESS | 13569 | __metrics Screen width/height:1600/1200 19:01:07 INFO - PROCESS | 13569 | colorDepth:24 19:01:07 INFO - PROCESS | 13569 | Browser inner width/height: 1024/697 19:01:07 INFO - PROCESS | 13569 | __metrics 19:01:07 INFO - PROCESS | 13569 | 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" 19:01:07 INFO - PROCESS | 13569 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:01:08 INFO - PROCESS | 13569 | console.error: PushService: 19:01:08 INFO - PROCESS | 13569 | stateChangeProcessEnqueue: Error transitioning state 19:01:08 INFO - PROCESS | 13569 | UnknownError 19:01:09 INFO - TEST-INFO | 13569: exit 0 19:01:09 INFO - Browser initialized. 19:01:09 INFO - Running cycle 1/1 for dromaeo_css test... 19:01:09 INFO - TEST-INFO | started process 13651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebQKDl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:21 INFO - PROCESS | 13651 | RSS: Main: 151736320 19:01:21 INFO - PROCESS | 13651 | 19:02:12 INFO - PROCESS | 13651 | 1483585332092 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] 19:04:26 INFO - PROCESS | 13651 | Cycle 1(1): loaded http://localhost:33951/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33951/tests/dromaeo/cssquery-ext.html) 19:04:27 INFO - PROCESS | 13651 | RSS: Main: 260202496 19:04:27 INFO - PROCESS | 13651 | 19:06:10 INFO - PROCESS | 13651 | ************************* 19:06:10 INFO - PROCESS | 13651 | A coding exception was thrown and uncaught in a Task. 19:06:10 INFO - PROCESS | 13651 | 19:06:10 INFO - PROCESS | 13651 | Full message: ReferenceError: fetch is not defined 19:06:10 INFO - PROCESS | 13651 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 19:06:10 INFO - PROCESS | 13651 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 19:06:10 INFO - PROCESS | 13651 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 19:06:10 INFO - PROCESS | 13651 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:06:10 INFO - PROCESS | 13651 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:06:10 INFO - PROCESS | 13651 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:06:10 INFO - PROCESS | 13651 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 19:06:10 INFO - PROCESS | 13651 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:06:10 INFO - PROCESS | 13651 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:06:10 INFO - PROCESS | 13651 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:06:10 INFO - PROCESS | 13651 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 19:06:10 INFO - PROCESS | 13651 | 19:06:10 INFO - PROCESS | 13651 | ************************* 19:07:30 INFO - PROCESS | 13651 | Cycle 1(1): loaded http://localhost:33951/tests/dromaeo/cssquery-ext.html (next: http://localhost:33951/tests/dromaeo/cssquery-jquery.html) 19:07:30 INFO - PROCESS | 13651 | RSS: Main: 236011520 19:07:30 INFO - PROCESS | 13651 | 19:10:33 INFO - PROCESS | 13651 | Cycle 1(1): loaded http://localhost:33951/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33951/tests/dromaeo/cssquery-mootools.html) 19:10:33 INFO - PROCESS | 13651 | RSS: Main: 183214080 19:10:33 INFO - PROCESS | 13651 | 19:13:36 INFO - PROCESS | 13651 | Cycle 1(1): loaded http://localhost:33951/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33951/tests/dromaeo/cssquery-prototype.html) 19:13:36 INFO - PROCESS | 13651 | RSS: Main: 185012224 19:13:36 INFO - PROCESS | 13651 | 19:16:39 INFO - PROCESS | 13651 | Cycle 1(1): loaded http://localhost:33951/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33951/tests/dromaeo/cssquery-yui.html) 19:16:40 INFO - PROCESS | 13651 | RSS: Main: 184176640 19:16:40 INFO - PROCESS | 13651 | 19:19:43 INFO - PROCESS | 13651 | Cycle 1(1): loaded http://localhost:33951/tests/dromaeo/cssquery-yui.html (next: http://localhost:33951/tests/dromaeo/cssquery-dojo.html) 19:19:43 INFO - PROCESS | 13651 | RSS: Main: 277397504 19:19:43 INFO - PROCESS | 13651 | 19:19:43 INFO - PROCESS | 13651 | __start_tp_report 19:19:43 INFO - PROCESS | 13651 | _x_x_mozilla_page_load 19:19:43 INFO - PROCESS | 13651 | _x_x_mozilla_page_load_details 19:19:43 INFO - PROCESS | 13651 | |i|pagename|runs| 19:19:43 INFO - PROCESS | 13651 | |0;dojo.html;2576.2528866628672;2593.2349956762755;2605.1142611512087;2620.973790262097;2625.1599488163797;4588.220002599558;4647.093816705744;4773.260144677572;4779.64152688548;4783.641226907983;4717.4574923883765;4742.928856067162;4763.59509441697;4794.400699912511;4835.564799168074;4339.479262488506;4381.890452738675;4389.297712366022;4408.052268762215;4433.84481543146;4335.241332766769;4403.4495688039;4410.470743510783;4453.621442177418;4493.281075027996;4403.735775853427;4427.00392411708;4438.112377524476;4446.199684056868;4484.932726009112;4239.660827133853;4270.722403043792;4284.61438470536;4391.033972526039;4415.867523974286;4405.801738921757;4423.225935461282;4477.552244775529;4484.7084939479155;4497;4749.073930583538;4813.374261346037;4872.975635121802;4876.561109500162;4884.023195360906;4959.429665588467;5022.070916880352;5216.7913283468615;5222.556082732972;5257;5131.384233891919;5161.561267292284;5188.740562971836;5220.399654039796;5268.5521730652945;4845.224764037737;4866.148424025781;4866.95133048665;4875.1224779540025;4915.729634870045;5046.142155833517;5303.496167864047;5304;5322.654027488201;5328.653637513627;4857.53853383935;4990.3762029746285;5022.472640372781;5031.371078615173;5095.923561146586;4979.3526841510375;5135.768890399866;5141.845744627667;5148.176291793295;5152.510511501401;4988.650794444354;4997.725125118153;5063.0380227756605;5081.441041485434;5089.3638295213095;5048.192289233705;5091.847244582595;5100.668456550312;5109.514596113363;5142.537171654494;3915.7454765440157;3951.4863067801;3955.564887862333;3978.840846366171;3990.5610382857863;3496.8426420811124;3505.614382417932;3533.6819686228364;3542.309249696336;3543.114221444639;4414.050979039458;4414.933775993362;4435.046465010038;4435.068635586563;4470.865874023784;5002;5056.84829455117;5116.411612664517;5137.640365174402;5180.8963820723375;4423.778811059434;4445.73325600465;4480.820767169277;4485.9775701121935;4496.662750293675;4676.672632915664;4687.671862969628;4688.484266730657;4689.601383882408;4725.621950243973;4735.952640473552;4772.928406073981;4794.30482580017;4864.537868902448;4872.537108974641;5125.92311115341;5138.023775482647;5141.151709967813;5187.714675692873;5192.870178245574;4816.614670826255;4817.084753896748;4824.710517368969;4844.903101937871;4873.975630121827;4871.610271178368;4922.138625740409;5051.722155281494;5054.924176137288;5110.3356563646485;5106.795728170831;5156.639035267495;5165.9483405166975;5181.3005244291535;5234;4770.570648641639;4786;4796.472388037243;4815.590674792542;4823.1800593898415;4571.26859702446;4585.72485650862;4599.586037256529;4695.976520117514;4730.385049943486;4718.3394324795245;4791.113643975876;4811.08589368019;4831.589314908272;4886.389201349832;4952.232403977389;4964.975175124101;4967;4980.8754781130765;5031.245313203049;4681.906361872675;4848.854534363974;4858.611311095033;4861.829835955725;4862.781174847069 19:19:43 INFO - PROCESS | 13651 | |1;ext.html;527.5779376498801;548.5638917060936;552.3344370034109;552.5165480204821;569.2173261765073;28845;31670.52494212586;31767.36465270696;38961.22077558447;41123;40519.79740101303;40844.79577602115;40854.38718419219;40892;40989.7950510247;7610.733624323164;7784.80537986552;7785.182555831613;7796.181400952875;7844.1763614820475;7580.810479737996;7706.845863082735;7776;10039.397636141819;10292.588296468133;10069;10079.748006299827;10095.798084038315;10169.644062457815;10240.846387304196;9960.402375857435;9972.703548538717;10004.59981600735;10018.89981100187;10034.096931276184;9818.410895346302;9923.106920377128;9931.70204893847;9933.056359645821;9941.850872236922;38613.61386386128;38669;38702.80648596739;38787.41818872719;38871.61128388708;3435.6220815710503;3516.859325626972;3534.469829525566;3548.3258180945536;3553.378158822222;27509.587356189673;27808.721912781017;28271.85864070687;28275;28341.57487637687;3468.791872487659;3482.4776283557417;3576.946345804815;3589.264200838848;3647.471116688065;232265;232762.9999999983;234167;234670;234779;52198.739006305485;52278.738606306724;52303.108471559164;52423.73788131111;52957.47042529525;56048.719756400955;56308.43691563114;56367.71816140975;56397.43602564004;56495.71752141213;13910.374033168531;14514.564563063124;14528.709425811425;14531.78202326966;14533.78199327011;9827.656032038843;10803.081738052353;10997.890021099687;10998.615048473264;10999.450027498593;13913.234772087633;15436.691266174837;15895.841041589436;15915;16094.75857862133;5974.163617093611;5986.2517185351835;6007.15899774032;6097.237845269341;6125.816225513242;742.8068702137483;793.4485532554819;799.5083023940235;805.6414895371504;810.3071873548149;27475.17574472769;28015;28457.430851382855;28838.567421488693;28930.42139157205;807.0073809214582;903.9276857851356;906.3293163059288;907.419251678926;913.992963151225;12898.419571119322;13189;13535.796963045563;13559.932200338935;13566.728665426834;351316;351884;352935;353001;353898;44142.33786493205;44332.77833610876;44345.334819977725;44360.77819610881;44399.112017759464;1156.3986726901796;1197.7963746163;1217.6407959651747;1218.9817152742717;1219.7316590350108;22770.20304289342;22823.543529129656;24250.63624045676;24270.393240168432;24395.878020610493;35571.82214088913;36915.63084369229;36979.630203698696;36994.44508332431;37000.81499592485;303210;303971;304345;305758;305871;20963.371098867057;21106.251093503837;23346.883265583565;23354.18260360879;23360.18239361614;30039.3992120152;35584.46623300704;39873.80063099666;40569.90026745249;40759.59240407558;31203.68796312008;31552.84223578959;31863;31874.362512750078;32814.17964550905;32083.839580801945;32203.838980804947;32215;32547.674523254464;32562.837185813918;28813.96604475333;29089.563656544746;29128;32124.753625490554;32393.838030809697;26194;29076.854615726785;29148.7085129146;29207.707922920497;29474.852625736734;22532;22931.78954946342;23305.533889321778;24837.379065523506;24944.750552494243 19:19:43 INFO - PROCESS | 13651 | |2;jquery.html;357.30682475996565;357.89621009907125;362.535953978907;366.9981650091749;380.07072707230816;16289.83710162898;17054.573635659082;17580.47258582243;17621.559461013465;17740.112994350264;16051.91974040131;16826.747598785998;16832.24254908529;16992;17052.573685657866;4867.440244371898;5096.4648711885275;5108.846734597968;5117.692938423706;5120.769565369549;3892.5134358205223;4085.5710150434224;5004.049230646184;5697.886042279152;5978.611390259619;5976.8505787355225;5981.252343457068;5990.760369585211;6063.727132279036;6078.17944577483;5707.77168913243;5892.823215303569;5924.14099955504;5994.520438364964;6011.699415029275;5050.419201791804;5253.737313134328;5257.211418287249;5259.894802103937;5260.815871444519;20980.475488112766;21096.578068438546;21332.893335533223;21386;21438.24966126178;2179.564087182554;2216.36833502451;2231.7991380775647;2251.4033781048033;2283.8515496492673;13280.734385312337;13334.933325333312;13711.862881371258;13774.380152893144;14087.929560352133;1726.9568260793455;1737.5829800847832;1739.3042782886946;1750.1861634339966;1760.3398725477946;75695;76507.23492765112;77990.61004694997;78259.21740782577;80161;9548.474833884204;9765;9807.31348805591;9897.109260166619;9915.553800079013;12821.423035963404;13150.473981040843;13172.538961136313;13185.142965707199;13188.208707477583;7143.699394701724;7157.105361829771;7291.416686665054;7307.232740562271;7390.630468476555;6840.863182736317;6901.792946211622;7034.718611255595;7114.71541138359;7121.750738724119;6141.6007959482495;6284.4344009039405;6318.936810631927;6374.330695277022;6399.616023038632;1624.5045261195212;1647.8187399386297;1708.5813975575816;1717.2615775216527;1763.1360633289596;789.6051974012994;795.7175202803037;801.7875263055295;805.6374631415887;828.2462958707547;17289.654206916042;17399.47801565955;17925.46223613294;18064.81935180658;18579.44261672125;807.1363640904293;809.4455298120806;819.7540737778643;825.1995564302617;829.3282441222628;9056;10021.39871607706;10092.343997640277;10174.13519850821;10210.234232432449;220434;221818;222161;373059;376867;91289;94158.52920735352;95508;96530.51734741281;96536.51731741296;903.1961554216753;946.2477330522252;951.8524628682427;958.5399008475831;959.2374062620233;15313.310901009258;15460.072395656296;15670.843291566938;15700.921495392908;16178.757318640466;35503.28993420066;35596.82201588975;37006.814965925;40058.39912401258;40830.183396332504;50020.49979500158;54504;54680;55957;56781;7839.490433121829;7874.606269686607;8033.55815430157;8057.153998830273;8083.514989100673;11806.763864722829;12263.26420414778;12342.13605047638;12738.235705857678;12761.74476510446;10124.088832005154;10346.844797327896;10520.526576304237;10686.412247326472;11055.94472027667;10700.913321902155;10758.13934885223;10770.73073173177;10890.23768336209;10952.616658416917;9897.802043959224;9999.35004224723;10777.515011824644;10995.890041099807;11251.606193783178;7868.763937081897;7917;7946.086200087064;8039.959800200962;8199.385046121684;10074.14369778577;10483.47582620881;10567.471626418495;10672.199585030998;10748.301360411548 19:19:43 INFO - PROCESS | 13651 | |3;mootools.html;1266.4617537546546;1276.2916581297388;1276.5532063777675;1277.827493288406;1288.3622606809631;6319.462845658119;6700.128983232185;6712.295209003051;6714.496412769037;6728.058071869942;5575.470330318623;5784.797532086378;6261;6520.869582608345;6544.312847151052;1993.7308463357442;2052.0150327842643;2058.577991511744;2065.2048961149917;2074.1081335025933;2024.8076432738867;2053.58928214357;2055.7122002919605;2090.25795842476;2091.362134548962;1755.8419742223198;1810.9909450452728;1822.562584979602;1824.644194382096;1833.294181740033;1973.289615738333;2034.257496013959;2038.1745393115812;2050.2516581447812;2053.435305291042;2063.566651003291;2070.3995841206033;2090.4669309326177;2096.088201632295;2096.2139197800825;6514.609123452608;6562.967185164043;6578.440832529241;6632.63520506372;6649.235337936103;4062.5734297898885;4178.623923846869;4180.268453020709;4180.372944058385;4180.728252663567;2619.292790946434;2674.3314171457137;2712.4846279207086;2757.54500507416;2758.2690586994263;1027.9557367501486;1039.2413538117141;1075.7794652096302;1076.8438576406456;1091.2143256855052;8510.74467765968;8594.441361311494;8599.226069653761;8611.741647750514;8626.870596941051;3557.6442355764216;3728.8508459661853;3735.7945313008045;3772.5095737553943;3779.130799916035;7537.849243015109;7552.282533159341;7570.810729731801;7574.3183113520045;7592.126905405949;4179.414881916534;4180.393842892763;4181.91636167281;4181.97909010453;4183.686223533186;3763.096856754414;3824.254270417242;3883.0292426893275;3884.1843212925037;3889.0471834400755;3218.613766348053;3260.739140868725;3261.8471808606205;3277.524758909945;3342.5821772278464;1078.5685725709623;1079.9730006749737;1084.9476008271963;1093.191038631407;1095.3482677806692;576.5531712922435;673.8147009572407;780.574586850168;803.6022169026253;807.1726480357563;4243.681723870722;4577.29051996941;4579.198640237945;4643.326717625925;4714.269288260325;485.0517238798141;489.3467221259587;492.3107649291021;492.68221996811855;610.2311088029027;3010.1722026442903;3234.4178047951123;3244.8864289749745;3276.4430046892085;3354.0608629583758;7501.587412692245;7678.846423071507;7799.766007019798;7805.102413222438;7806.68773249075;7716.884246736304;7738.458307918504;7739.922600774033;7759.7672069838;7760.262775036363;6158.784442544489;6166.660833654192;6250.656213908188;6277.5605707600025;6323.146375239284;4410.977945110254;4435.977820110878;4512.526184750685;4532.093581283691;4622.2835460503675;7161.749338773118;7175.461840362098;7176.138863336224;7266.818329541804;7305.050343455317;7287.307705767944;7303.488755787044;7316.561006339423;7400.444966627632;7411.4070874328845;5726.885462290814;5837.357890631942;5935.673537955454;6034.487068599218;6044.576879618385;6415.454686351713;6457.870842583028;6474.320196379313;6480.54636175482;6480.837979050561;5840.2115714378015;5899.085641725539;5908.645481271137;5915.349311575809;6062.151298818258;5857;5857.5313974881055;5872.588918775645;5900.616459930091;5911.852203694942;5100.668456550312;5180.378354597472;5180.6891586504935;5181.119209734279;5181.2746215529105;3923.2349691809823;3965.1276719121747;4016.678665706795;4026.7382620129597;4140.648044916095;3988.5213774346103;4028.91942161161;4032.5362583303295;4076.2458945095254;4162.937555936724 19:19:43 INFO - PROCESS | 13651 | |4;prototype.html;333.3333333333333;338.47198370541946;345.97059249963735;346.12948434686757;348.491202843848;4858.5627293543575;4915.852524424264;4920.557149856512;4926.546668732723;4938.950610493894;4846.497585748411;4868.391451068616;4872.70763754175;4877.292792545079;4911.8211629209;3665.211979424423;3790.829412676422;3832.5400951885813;3851.42228665701;3879.1465877506903;3834.5206849143856;3877.515310586177;3907.960920390802;3915.9021024474473;3917.5886531914166;3836.405357169629;3845.3270677631444;3856.190200057991;3871.7676939383728;3877.6316249956208;3703.9629603704157;3787.299349620329;3832.367659336206;3873.9031524211837;3885.785102491581;3424.178197232671;3446.551948246737;3452.8273586320583;3461.930761384758;3469.340825243196;4692.859214223545;4749.810007599692;4755.500672429414;4759;4783.856484305476;4321.567843215685;4421.9115617687785;4436.201483732927;4436.889077773049;4437.2013037653205;5042.184813467149;5089.440161582223;5097.337346144977;5097.592192624581;5105.770240339194;3771.264603402338;3784.280986612535;3792.5448946126367;3795;3801.6958643308744;5166.250893620404;5379.273798037293;5390.326209223847;5399;5427.864303392407;3858.479105320746;3876.825542850522;3884.320243957353;3893.014562573108;3893.8053097345587;3940.9211815763524;3942.955116894025;3954.8220330085214;3956.5647778744315;3969.900752481211;4429.446319210098;4448.799804008828;4460.933086003713;4461.709988850779;4462.196804575207;5017.473165317662;5069.797208111708;5099.87250318745;5123.8719032023755;5192.584593232608;1311.2001678975817;1311.9803202951964;1325.7414804113105;1328.940197691087;1330.3015916643647;914.8170365926841;950.4107453378949;954.3128947158035;971.4899677669139;972.2999440402899;4225.7887105644595;4355.934660980088;4368.934465983013;4528.320751887178;4535.138323718483;5256.894862102737;5265.420803711589;5272.841814745564;5282.392524859613;5284.9471505284455;4502.324651302265;4504.990558403024;4505.391772110723;4535.9773201133785;4551.338761352083;2557.7314381989995;2676.3978104926236;2691.4347986922576;2703.580620174385;2704.7287774745837;4803.022126281658;4811.3745213122775;4814.253790662453;4816.325714399917;4822.71063736177;5035.571976381975;5122.948770512247;5137.460566640524;5193.610479214074;5195.48045195485;4746.359241502353;4795.472498025214;4809.615230781599;4816.710997340101;4836.903261934742;5069.569086627531;5089.211172268304;5135.820246291362;5154.5824898153305;5159.561437277874;4926.556609905126;5080.796768129233;5086.720230387365;5086.847394578169;5091.1854103343285;4928.630352723489;4937.185364414831;4956.925646115239;4962.33008543842;4970.304157418037;3652.9634703653687;3681.5398075240596;3707.4068149096015;3715.479832823461;3719.9070023249637;5139.177731562932;5355.22349259363;5355.973220133875;5369.140937449989;5375.784968601369;4893.9021219576125;4909.779059942382;4913.140200464833;4913.420454261542;4954.405471343462;4864.148773964613;4869.853904382874;4881.9023619528125;4907.214845624683;4910.558049775537;4725.29120631908;4920.286558449076;4945.431275403231;4951.752412379295;4956.686478083383;4829.855104346875;4929.260610908393;4936.259561065869;5032.370953630796;5048.242763585492;4911.361523001987;4915.729634870117;4920.6555541111775;4927.18701414277;4928.334674818997 19:19:43 INFO - PROCESS | 13651 | |5;yui.html;579.9768009279629;599.9760009599617;655.8983357579575;660.9471242300615;670.6345041952136;11337.979581837633;12289.877101228985;12526.686832829173;13262.137961032526;13410.262435566065;13990.090644108152;14142.505012324571;14175.668717851297;14309.212993285366;15000.924995375035;798.9520628762264;814.2793627639522;818.6848063495568;819.0253598218131;820.0528389709895;667.3860048755157;685.8971154326841;792.1049214387763;810.2626609785067;811.4401063266328;861.5562985062697;863.3266052479045;864.1229152410277;865.5845194306737;865.6580650642992;852.9977276699852;853.1596377568121;853.6158728572105;854.1671869926834;856.6359297298624;517.7902949305537;531.9920201196985;606.2270604978644;620.9658468784215;632.996835015822;12090.09324300681;12090.455929483194;12131.029517638568;12136.635900922987;12140.45367958444;12307.507699692002;12547.93726031364;12629.557965471256;12719.427625756864;12872.16330938486;12149.271043737404;12159.600997506235;12180.451879665348;12283;12426.192297500633;4035.3946907963746;4069.0844559974066;4070.450489183952;4107.424960505532;4146.958530414688;62587;63448.68275658592;63478.36521634817;64197.358026419606;64578;10062.748431289276;10064.144547713526;10201.744956376002;10233.641822536176;10345.689629311133;17769.7334539982;18433.723494147598;18702.812971870106;19719.309824156087;19721.211151554064;6667;6744.898826517508;6779.694913728894;6830.385265326145;6905.551139175937;3531.205478767257;3550.6626870447267;3577.624349443271;3594.119440736984;3628.8367023484006;2870.468963241807;2929.5019846626124;2940.0444855421647;2968.139239620486;2970.9257268568026;490.6712502623251;495.10880415252404;495.55895253224656;495.58370968386726;498.16308601549747;615.7752420366534;627.4071002902214;629.2040568680623;632.2665707778955;646.1535388640896;6943.72225111;7167.749128780468;7691.115521714963;7754.108277548042;7927.643256053491;591.8872519663006;607.9817605471843;613.6471528870828;617.9660118693515;622.5922021076202;3701.11173318407;3804;3813.2182902505474;3816.6183381661613;3845.6731177850197;53030.73484632629;53765;53854.46145538573;59339;66731;46179.76910115428;47221;48256.5174348259;59070.40929590735;59304;47389.526104738514;48272.75863620659;48971.26543101856;49160.50839491631;52357.7382113087;8238.629261683358;8348.749537513884;8431.704890328809;8512.543465608229;8661.480311181349;34961.30077398387;35336.82331588326;35421.291574168885;35810.64189358177;37104;40994.1801163981;42609.78695106505;43042.56957430386;43577.56422435735;44967.55032449633;11245.123795876072;11476.770464590494;11579.536818527165;11669.183157178915;11962.58130965412;12478.937605311916;12522.624321270376;12718.236905785683;12803.423845927142;13254.204747715168;12079.858979183598;12253.529576450883;12515.311657858905;12627.873721263037;12932.640210133999;11116.277441966246;11242.775144497227;11321;11321.377324246916;11916.469825046095;11131.610393636183;11136.554537818396;11460.656180314603;11626.128040397174;11844;9232.630694772133;9355.532223388667;9361.625534978524;9444.244460443286;9598.32811703174;8892;9115.589798459217;9245.121713437213;9272.304577156605;9371.906280937375 19:19:43 INFO - PROCESS | 13651 | __end_tp_report 19:19:43 INFO - PROCESS | 13651 | __start_cc_report 19:19:43 INFO - PROCESS | 13651 | _x_x_mozilla_cycle_collect,1194 19:19:43 INFO - PROCESS | 13651 | __end_cc_report 19:19:43 INFO - PROCESS | 13651 | __startTimestamp1483586383592__endTimestamp 19:19:43 INFO - PROCESS | 13651 | 19:19:43 INFO - PROCESS | 13651 | ------- Summary: start ------- 19:19:43 INFO - PROCESS | 13651 | Number of tests: 6 19:19:43 INFO - PROCESS | 13651 | 19:19:43 INFO - PROCESS | 13651 | [#0] dojo.html Cycles:165 Average:4692.93 Median:4816.61 stddev:528.41 (11.0%) stddev-sans-first:503.27 19:19:43 INFO - PROCESS | 13651 | Values: 2576.3 2593.2 2605.1 2621.0 2625.2 4588.2 4647.1 4773.3 4779.6 4783.6 4717.5 4742.9 4763.6 4794.4 4835.6 4339.5 4381.9 4389.3 4408.1 4433.8 4335.2 4403.4 4410.5 4453.6 4493.3 4403.7 4427.0 4438.1 4446.2 4484.9 4239.7 4270.7 4284.6 4391.0 4415.9 4405.8 4423.2 4477.6 4484.7 4497.0 4749.1 4813.4 4873.0 4876.6 4884.0 4959.4 5022.1 5216.8 5222.6 5257.0 5131.4 5161.6 5188.7 5220.4 5268.6 4845.2 4866.1 4867.0 4875.1 4915.7 5046.1 5303.5 5304.0 5322.7 5328.7 4857.5 4990.4 5022.5 5031.4 5095.9 4979.4 5135.8 5141.8 5148.2 5152.5 4988.7 4997.7 5063.0 5081.4 5089.4 5048.2 5091.8 5100.7 5109.5 5142.5 3915.7 3951.5 3955.6 3978.8 3990.6 3496.8 3505.6 3533.7 3542.3 3543.1 4414.1 4414.9 4435.0 4435.1 4470.9 5002.0 5056.8 5116.4 5137.6 5180.9 4423.8 4445.7 4480.8 4486.0 4496.7 4676.7 4687.7 4688.5 4689.6 4725.6 4736.0 4772.9 4794.3 4864.5 4872.5 5125.9 5138.0 5141.2 5187.7 5192.9 4816.6 4817.1 4824.7 4844.9 4874.0 4871.6 4922.1 5051.7 5054.9 5110.3 5106.8 5156.6 5165.9 5181.3 5234.0 4770.6 4786.0 4796.5 4815.6 4823.2 4571.3 4585.7 4599.6 4696.0 4730.4 4718.3 4791.1 4811.1 4831.6 4886.4 4952.2 4965.0 4967.0 4980.9 5031.2 4681.9 4848.9 4858.6 4861.8 4862.8 19:19:43 INFO - PROCESS | 13651 | 19:19:43 INFO - PROCESS | 13651 | [#1] ext.html Cycles:180 Average:44400.23 Median:32555.26 stddev:79115.42 (243.0%) stddev-sans-first:79268.78 19:19:43 INFO - PROCESS | 13651 | Values: 527.6 548.6 552.3 552.5 569.2 28845.0 31670.5 31767.4 38961.2 41123.0 40519.8 40844.8 40854.4 40892.0 40989.8 7610.7 7784.8 7785.2 7796.2 7844.2 7580.8 7706.8 7776.0 10039.4 10292.6 10069.0 10079.7 10095.8 10169.6 10240.8 9960.4 9972.7 10004.6 10018.9 10034.1 9818.4 9923.1 9931.7 9933.1 9941.9 38613.6 38669.0 38702.8 38787.4 38871.6 3435.6 3516.9 3534.5 3548.3 3553.4 27509.6 27808.7 28271.9 28275.0 28341.6 3468.8 3482.5 3576.9 3589.3 3647.5 232265.0 232763.0 234167.0 234670.0 234779.0 52198.7 52278.7 52303.1 52423.7 52957.5 56048.7 56308.4 56367.7 56397.4 56495.7 13910.4 14514.6 14528.7 14531.8 14533.8 9827.7 10803.1 10997.9 10998.6 10999.5 13913.2 15436.7 15895.8 15915.0 16094.8 5974.2 5986.3 6007.2 6097.2 6125.8 742.8 793.4 799.5 805.6 810.3 27475.2 28015.0 28457.4 28838.6 28930.4 807.0 903.9 906.3 907.4 914.0 12898.4 13189.0 13535.8 13559.9 13566.7 351316.0 351884.0 352935.0 353001.0 353898.0 44142.3 44332.8 44345.3 44360.8 44399.1 1156.4 1197.8 1217.6 1219.0 1219.7 22770.2 22823.5 24250.6 24270.4 24395.9 35571.8 36915.6 36979.6 36994.4 37000.8 303210.0 303971.0 304345.0 305758.0 305871.0 20963.4 21106.3 23346.9 23354.2 23360.2 30039.4 35584.5 39873.8 40569.9 40759.6 31203.7 31552.8 31863.0 31874.4 32814.2 32083.8 32203.8 32215.0 32547.7 32562.8 28814.0 29089.6 29128.0 32124.8 32393.8 26194.0 29076.9 29148.7 29207.7 29474.9 22532.0 22931.8 23305.5 24837.4 24944.8 19:19:43 INFO - PROCESS | 13651 | 19:19:43 INFO - PROCESS | 13651 | [#2] jquery.html Cycles:180 Average:22497.24 Median:21975.46 stddev:50157.47 (228.2%) stddev-sans-first:50270.62 19:19:43 INFO - PROCESS | 13651 | Values: 357.3 357.9 362.5 367.0 380.1 16289.8 17054.6 17580.5 17621.6 17740.1 16051.9 16826.7 16832.2 16992.0 17052.6 4867.4 5096.5 5108.8 5117.7 5120.8 3892.5 4085.6 5004.0 5697.9 5978.6 5976.9 5981.3 5990.8 6063.7 6078.2 5707.8 5892.8 5924.1 5994.5 6011.7 5050.4 5253.7 5257.2 5259.9 5260.8 20980.5 21096.6 21332.9 21386.0 21438.2 2179.6 2216.4 2231.8 2251.4 2283.9 13280.7 13334.9 13711.9 13774.4 14087.9 1727.0 1737.6 1739.3 1750.2 1760.3 75695.0 76507.2 77990.6 78259.2 80161.0 9548.5 9765.0 9807.3 9897.1 9915.6 12821.4 13150.5 13172.5 13185.1 13188.2 7143.7 7157.1 7291.4 7307.2 7390.6 6840.9 6901.8 7034.7 7114.7 7121.8 6141.6 6284.4 6318.9 6374.3 6399.6 1624.5 1647.8 1708.6 1717.3 1763.1 789.6 795.7 801.8 805.6 828.2 17289.7 17399.5 17925.5 18064.8 18579.4 807.1 809.4 819.8 825.2 829.3 9056.0 10021.4 10092.3 10174.1 10210.2 220434.0 221818.0 222161.0 373059.0 376867.0 91289.0 94158.5 95508.0 96530.5 96536.5 903.2 946.2 951.9 958.5 959.2 15313.3 15460.1 15670.8 15700.9 16178.8 35503.3 35596.8 37006.8 40058.4 40830.2 50020.5 54504.0 54680.0 55957.0 56781.0 7839.5 7874.6 8033.6 8057.2 8083.5 11806.8 12263.3 12342.1 12738.2 12761.7 10124.1 10346.8 10520.5 10686.4 11055.9 10700.9 10758.1 10770.7 10890.2 10952.6 9897.8 9999.4 10777.5 10995.9 11251.6 7868.8 7917.0 7946.1 8040.0 8199.4 10074.1 10483.5 10567.5 10672.2 10748.3 19:19:43 INFO - PROCESS | 13651 | 19:19:43 INFO - PROCESS | 13651 | [#3] mootools.html Cycles:180 Average:4390.29 Median:4578.24 stddev:2305.76 (50.4%) stddev-sans-first:2300.27 19:19:43 INFO - PROCESS | 13651 | Values: 1266.5 1276.3 1276.6 1277.8 1288.4 6319.5 6700.1 6712.3 6714.5 6728.1 5575.5 5784.8 6261.0 6520.9 6544.3 1993.7 2052.0 2058.6 2065.2 2074.1 2024.8 2053.6 2055.7 2090.3 2091.4 1755.8 1811.0 1822.6 1824.6 1833.3 1973.3 2034.3 2038.2 2050.3 2053.4 2063.6 2070.4 2090.5 2096.1 2096.2 6514.6 6563.0 6578.4 6632.6 6649.2 4062.6 4178.6 4180.3 4180.4 4180.7 2619.3 2674.3 2712.5 2757.5 2758.3 1028.0 1039.2 1075.8 1076.8 1091.2 8510.7 8594.4 8599.2 8611.7 8626.9 3557.6 3728.9 3735.8 3772.5 3779.1 7537.8 7552.3 7570.8 7574.3 7592.1 4179.4 4180.4 4181.9 4182.0 4183.7 3763.1 3824.3 3883.0 3884.2 3889.0 3218.6 3260.7 3261.8 3277.5 3342.6 1078.6 1080.0 1084.9 1093.2 1095.3 576.6 673.8 780.6 803.6 807.2 4243.7 4577.3 4579.2 4643.3 4714.3 485.1 489.3 492.3 492.7 610.2 3010.2 3234.4 3244.9 3276.4 3354.1 7501.6 7678.8 7799.8 7805.1 7806.7 7716.9 7738.5 7739.9 7759.8 7760.3 6158.8 6166.7 6250.7 6277.6 6323.1 4411.0 4436.0 4512.5 4532.1 4622.3 7161.7 7175.5 7176.1 7266.8 7305.1 7287.3 7303.5 7316.6 7400.4 7411.4 5726.9 5837.4 5935.7 6034.5 6044.6 6415.5 6457.9 6474.3 6480.5 6480.8 5840.2 5899.1 5908.6 5915.3 6062.2 5857.0 5857.5 5872.6 5900.6 5911.9 5100.7 5180.4 5180.7 5181.1 5181.3 3923.2 3965.1 4016.7 4026.7 4140.6 3988.5 4028.9 4032.5 4076.2 4162.9 19:19:43 INFO - PROCESS | 13651 | 19:19:43 INFO - PROCESS | 13651 | [#4] prototype.html Cycles:180 Average:4231.48 Median:4812.81 stddev:1192.83 (24.8%) stddev-sans-first:1159.74 19:19:43 INFO - PROCESS | 13651 | Values: 333.3 338.5 346.0 346.1 348.5 4858.6 4915.9 4920.6 4926.5 4939.0 4846.5 4868.4 4872.7 4877.3 4911.8 3665.2 3790.8 3832.5 3851.4 3879.1 3834.5 3877.5 3908.0 3915.9 3917.6 3836.4 3845.3 3856.2 3871.8 3877.6 3704.0 3787.3 3832.4 3873.9 3885.8 3424.2 3446.6 3452.8 3461.9 3469.3 4692.9 4749.8 4755.5 4759.0 4783.9 4321.6 4421.9 4436.2 4436.9 4437.2 5042.2 5089.4 5097.3 5097.6 5105.8 3771.3 3784.3 3792.5 3795.0 3801.7 5166.3 5379.3 5390.3 5399.0 5427.9 3858.5 3876.8 3884.3 3893.0 3893.8 3940.9 3943.0 3954.8 3956.6 3969.9 4429.4 4448.8 4460.9 4461.7 4462.2 5017.5 5069.8 5099.9 5123.9 5192.6 1311.2 1312.0 1325.7 1328.9 1330.3 914.8 950.4 954.3 971.5 972.3 4225.8 4355.9 4368.9 4528.3 4535.1 5256.9 5265.4 5272.8 5282.4 5284.9 4502.3 4505.0 4505.4 4536.0 4551.3 2557.7 2676.4 2691.4 2703.6 2704.7 4803.0 4811.4 4814.3 4816.3 4822.7 5035.6 5122.9 5137.5 5193.6 5195.5 4746.4 4795.5 4809.6 4816.7 4836.9 5069.6 5089.2 5135.8 5154.6 5159.6 4926.6 5080.8 5086.7 5086.8 5091.2 4928.6 4937.2 4956.9 4962.3 4970.3 3653.0 3681.5 3707.4 3715.5 3719.9 5139.2 5355.2 5356.0 5369.1 5375.8 4893.9 4909.8 4913.1 4913.4 4954.4 4864.1 4869.9 4881.9 4907.2 4910.6 4725.3 4920.3 4945.4 4951.8 4956.7 4829.9 4929.3 4936.3 5032.4 5048.2 4911.4 4915.7 4920.7 4927.2 4928.3 19:19:43 INFO - PROCESS | 13651 | 19:19:43 INFO - PROCESS | 13651 | [#5] yui.html Cycles:180 Average:14319.29 Median:46700.38 stddev:17272.33 (37.0%) stddev-sans-first:17289.97 19:19:43 INFO - PROCESS | 13651 | Values: 580.0 600.0 655.9 660.9 670.6 11338.0 12289.9 12526.7 13262.1 13410.3 13990.1 14142.5 14175.7 14309.2 15000.9 799.0 814.3 818.7 819.0 820.1 667.4 685.9 792.1 810.3 811.4 861.6 863.3 864.1 865.6 865.7 853.0 853.2 853.6 854.2 856.6 517.8 532.0 606.2 621.0 633.0 12090.1 12090.5 12131.0 12136.6 12140.5 12307.5 12547.9 12629.6 12719.4 12872.2 12149.3 12159.6 12180.5 12283.0 12426.2 4035.4 4069.1 4070.5 4107.4 4147.0 62587.0 63448.7 63478.4 64197.4 64578.0 10062.7 10064.1 10201.7 10233.6 10345.7 17769.7 18433.7 18702.8 19719.3 19721.2 6667.0 6744.9 6779.7 6830.4 6905.6 3531.2 3550.7 3577.6 3594.1 3628.8 2870.5 2929.5 2940.0 2968.1 2970.9 490.7 495.1 495.6 495.6 498.2 615.8 627.4 629.2 632.3 646.2 6943.7 7167.7 7691.1 7754.1 7927.6 591.9 608.0 613.6 618.0 622.6 3701.1 3804.0 3813.2 3816.6 3845.7 53030.7 53765.0 53854.5 59339.0 66731.0 46179.8 47221.0 48256.5 59070.4 59304.0 47389.5 48272.8 48971.3 49160.5 52357.7 8238.6 8348.7 8431.7 8512.5 8661.5 34961.3 35336.8 35421.3 35810.6 37104.0 40994.2 42609.8 43042.6 43577.6 44967.6 11245.1 11476.8 11579.5 11669.2 11962.6 12478.9 12522.6 12718.2 12803.4 13254.2 12079.9 12253.5 12515.3 12627.9 12932.6 11116.3 11242.8 11321.0 11321.4 11916.5 11131.6 11136.6 11460.7 11626.1 11844.0 9232.6 9355.5 9361.6 9444.2 9598.3 8892.0 9115.6 9245.1 9272.3 9371.9 19:19:43 INFO - PROCESS | 13651 | -------- Summary: end -------- 19:19:43 INFO - PROCESS | 13651 | 19:19:44 INFO - TEST-INFO | 13651: exit 0 19:19:44 INFO - TEST-OK | dromaeo_css | took 1121331ms 19:19:44 INFO - TEST-START | kraken 19:19:44 INFO - operating with platform_type : linux_ 19:19:44 INFO - Initialising browser for kraken test... 19:19:44 INFO - TEST-INFO | started process 13958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBDvWwA/profile http://localhost:33951/getInfo.html) 19:19:45 INFO - PROCESS | 13958 | 1483586385003 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:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 19:19:48 INFO - PROCESS | 13958 | __metrics Screen width/height:1600/1200 19:19:48 INFO - PROCESS | 13958 | colorDepth:24 19:19:48 INFO - PROCESS | 13958 | Browser inner width/height: 1024/697 19:19:48 INFO - PROCESS | 13958 | __metrics 19:19:49 INFO - PROCESS | 13958 | 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" 19:19:49 INFO - PROCESS | 13958 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:19:49 INFO - PROCESS | 13958 | console.error: PushService: 19:19:49 INFO - PROCESS | 13958 | stateChangeProcessEnqueue: Error transitioning state 19:19:49 INFO - PROCESS | 13958 | UnknownError 19:19:50 INFO - TEST-INFO | 13958: exit 0 19:19:50 INFO - Browser initialized. 19:19:50 INFO - Running cycle 1/1 for kraken test... 19:19:50 INFO - TEST-INFO | started process 14041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBDvWwA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:02 INFO - PROCESS | 14041 | RSS: Main: 151302144 19:20:02 INFO - PROCESS | 14041 | 19:20:05 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33951/tests/kraken/driver.html?testName=audio-beat-detection) 19:20:06 INFO - PROCESS | 14041 | RSS: Main: 205389824 19:20:06 INFO - PROCESS | 14041 | 19:20:08 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33951/tests/kraken/driver.html?testName=audio-dft) 19:20:09 INFO - PROCESS | 14041 | RSS: Main: 184848384 19:20:09 INFO - PROCESS | 14041 | 19:20:12 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33951/tests/kraken/driver.html?testName=audio-fft) 19:20:13 INFO - PROCESS | 14041 | RSS: Main: 267829248 19:20:13 INFO - PROCESS | 14041 | 19:20:15 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33951/tests/kraken/driver.html?testName=audio-oscillator) 19:20:16 INFO - PROCESS | 14041 | RSS: Main: 179019776 19:20:16 INFO - PROCESS | 14041 | 19:20:18 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33951/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:18 INFO - PROCESS | 14041 | RSS: Main: 182214656 19:20:18 INFO - PROCESS | 14041 | 19:20:22 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33951/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:22 INFO - PROCESS | 14041 | RSS: Main: 220831744 19:20:22 INFO - PROCESS | 14041 | 19:20:26 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33951/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:26 INFO - PROCESS | 14041 | RSS: Main: 215228416 19:20:26 INFO - PROCESS | 14041 | 19:20:29 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33951/tests/kraken/driver.html?testName=json-parse-financial) 19:20:30 INFO - PROCESS | 14041 | RSS: Main: 216485888 19:20:30 INFO - PROCESS | 14041 | 19:20:31 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33951/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:32 INFO - PROCESS | 14041 | RSS: Main: 180260864 19:20:32 INFO - PROCESS | 14041 | 19:20:34 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33951/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:35 INFO - PROCESS | 14041 | RSS: Main: 188375040 19:20:35 INFO - PROCESS | 14041 | 19:20:37 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33951/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:37 INFO - PROCESS | 14041 | RSS: Main: 196710400 19:20:37 INFO - PROCESS | 14041 | 19:20:40 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33951/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:41 INFO - PROCESS | 14041 | RSS: Main: 200593408 19:20:41 INFO - PROCESS | 14041 | 19:20:44 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33951/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:45 INFO - PROCESS | 14041 | RSS: Main: 202682368 19:20:45 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:33951/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33951/tests/kraken/driver.html?testName=ai-astar) 19:20:47 INFO - PROCESS | 14041 | RSS: Main: 252825600 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | __start_tp_report 19:20:47 INFO - PROCESS | 14041 | _x_x_mozilla_page_load 19:20:47 INFO - PROCESS | 14041 | _x_x_mozilla_page_load_details 19:20:47 INFO - PROCESS | 14041 | |i|pagename|runs| 19:20:47 INFO - PROCESS | 14041 | |0;ai-astar;114;116;116;116;116;114;115;115;114;116 19:20:47 INFO - PROCESS | 14041 | |1;audio-beat-detection;157;129;127;180;133;134;127;126;152;128 19:20:47 INFO - PROCESS | 14041 | |2;audio-dft;161;162;162;161;163;164;163;162;164;163 19:20:47 INFO - PROCESS | 14041 | |3;audio-fft;76;77;79;130;77;78;77;77;94;78 19:20:47 INFO - PROCESS | 14041 | |4;audio-oscillator;85;84;109;84;85;85;110;86;85;112 19:20:47 INFO - PROCESS | 14041 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;117;117 19:20:47 INFO - PROCESS | 14041 | |6;imaging-darkroom;149;150;150;150;149;149;150;150;148;151 19:20:47 INFO - PROCESS | 14041 | |7;imaging-desaturate;95;95;95;97;97;96;95;97;95;97 19:20:47 INFO - PROCESS | 14041 | |8;json-parse-financial;62;62;62;62;62;62;64;62;63;63 19:20:47 INFO - PROCESS | 14041 | |9;json-stringify-tinderbox;68;67;67;67;69;67;68;67;67;68 19:20:47 INFO - PROCESS | 14041 | |10;stanford-crypto-aes;85;94;88;96;85;84;93;85;85;85 19:20:47 INFO - PROCESS | 14041 | |11;stanford-crypto-ccm;137;135;134;134;131;132;146;132;231;146 19:20:47 INFO - PROCESS | 14041 | |12;stanford-crypto-pbkdf2;176;180;185;179;181;180;188;179;178;178 19:20:47 INFO - PROCESS | 14041 | |13;stanford-crypto-sha256-iterative;81;68;71;69;68;67;66;68;67;67 19:20:47 INFO - PROCESS | 14041 | __end_tp_report 19:20:47 INFO - PROCESS | 14041 | __start_cc_report 19:20:47 INFO - PROCESS | 14041 | _x_x_mozilla_cycle_collect,1884 19:20:47 INFO - PROCESS | 14041 | __end_cc_report 19:20:47 INFO - PROCESS | 14041 | __startTimestamp1483586447258__endTimestamp 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | ------- Summary: start ------- 19:20:47 INFO - PROCESS | 14041 | Number of tests: 14 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 19:20:47 INFO - PROCESS | 14041 | Values: 114.0 116.0 116.0 116.0 116.0 114.0 115.0 115.0 114.0 116.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:133.50 stddev:17.99 (13.5%) stddev-sans-first:17.90 19:20:47 INFO - PROCESS | 14041 | Values: 157.0 129.0 127.0 180.0 133.0 134.0 127.0 126.0 152.0 128.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 19:20:47 INFO - PROCESS | 14041 | Values: 161.0 162.0 162.0 161.0 163.0 164.0 163.0 162.0 164.0 163.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#3] audio-fft Cycles:10 Average:84.30 Median:77.50 stddev:16.91 (21.8%) stddev-sans-first:17.66 19:20:47 INFO - PROCESS | 14041 | Values: 76.0 77.0 79.0 130.0 77.0 78.0 77.0 77.0 94.0 78.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:85.00 stddev:12.34 (14.5%) stddev-sans-first:12.79 19:20:47 INFO - PROCESS | 14041 | Values: 85.0 84.0 109.0 84.0 85.0 85.0 110.0 86.0 85.0 112.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:20:47 INFO - PROCESS | 14041 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 19:20:47 INFO - PROCESS | 14041 | Values: 149.0 150.0 150.0 150.0 149.0 149.0 150.0 150.0 148.0 151.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.50 stddev:0.99 (1.0%) stddev-sans-first:1.00 19:20:47 INFO - PROCESS | 14041 | Values: 95.0 95.0 95.0 97.0 97.0 96.0 95.0 97.0 95.0 97.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 19:20:47 INFO - PROCESS | 14041 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 64.0 62.0 63.0 63.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 19:20:47 INFO - PROCESS | 14041 | Values: 68.0 67.0 67.0 67.0 69.0 67.0 68.0 67.0 67.0 68.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:86.50 stddev:4.55 (5.3%) stddev-sans-first:4.69 19:20:47 INFO - PROCESS | 14041 | Values: 85.0 94.0 88.0 96.0 85.0 84.0 93.0 85.0 85.0 85.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:136.00 stddev:30.43 (22.4%) stddev-sans-first:32.10 19:20:47 INFO - PROCESS | 14041 | Values: 137.0 135.0 134.0 134.0 131.0 132.0 146.0 132.0 231.0 146.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:180.00 stddev:3.57 (2.0%) stddev-sans-first:3.41 19:20:47 INFO - PROCESS | 14041 | Values: 176.0 180.0 185.0 179.0 181.0 180.0 188.0 179.0 178.0 178.0 19:20:47 INFO - PROCESS | 14041 | 19:20:47 INFO - PROCESS | 14041 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.00 stddev:4.37 (6.4%) stddev-sans-first:1.45 19:20:47 INFO - PROCESS | 14041 | Values: 81.0 68.0 71.0 69.0 68.0 67.0 66.0 68.0 67.0 67.0 19:20:47 INFO - PROCESS | 14041 | -------- Summary: end -------- 19:20:47 INFO - PROCESS | 14041 | 19:20:48 INFO - TEST-INFO | 14041: exit 0 19:20:48 INFO - TEST-OK | kraken | took 63970ms 19:20:48 INFO - SUITE-END | took 1185s 19:20:48 INFO - Completed test suite (00:19:45) 19:20:48 INFO - javascript benchmark 19:20:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.2528866628672, 2593.2349956762755, 2605.1142611512087, 2620.973790262097, 2625.1599488163797, 4588.220002599558, 4647.093816705744, 4773.260144677572, 4779.64152688548, 4783.641226907983, 4717.4574923883765, 4742.928856067162, 4763.59509441697, 4794.400699912511, 4835.564799168074, 4339.479262488506, 4381.890452738675, 4389.297712366022, 4408.052268762215, 4433.84481543146, 4335.241332766769, 4403.4495688039, 4410.470743510783, 4453.621442177418, 4493.281075027996, 4403.735775853427, 4427.00392411708, 4438.112377524476, 4446.199684056868, 4484.932726009112, 4239.660827133853, 4270.722403043792, 4284.61438470536, 4391.033972526039, 4415.867523974286, 4405.801738921757, 4423.225935461282, 4477.552244775529, 4484.7084939479155, 4497.0, 4749.073930583538, 4813.374261346037, 4872.975635121802, 4876.561109500162, 4884.023195360906, 4959.429665588467, 5022.070916880352, 5216.7913283468615, 5222.556082732972, 5257.0, 5131.384233891919, 5161.561267292284, 5188.740562971836, 5220.399654039796, 5268.5521730652945, 4845.224764037737, 4866.148424025781, 4866.95133048665, 4875.1224779540025, 4915.729634870045, 5046.142155833517, 5303.496167864047, 5304.0, 5322.654027488201, 5328.653637513627, 4857.53853383935, 4990.3762029746285, 5022.472640372781, 5031.371078615173, 5095.923561146586, 4979.3526841510375, 5135.768890399866, 5141.845744627667, 5148.176291793295, 5152.510511501401, 4988.650794444354, 4997.725125118153, 5063.0380227756605, 5081.441041485434, 5089.3638295213095, 5048.192289233705, 5091.847244582595, 5100.668456550312, 5109.514596113363, 5142.537171654494, 3915.7454765440157, 3951.4863067801, 3955.564887862333, 3978.840846366171, 3990.5610382857863, 3496.8426420811124, 3505.614382417932, 3533.6819686228364, 3542.309249696336, 3543.114221444639, 4414.050979039458, 4414.933775993362, 4435.046465010038, 4435.068635586563, 4470.865874023784, 5002.0, 5056.84829455117, 5116.411612664517, 5137.640365174402, 5180.8963820723375, 4423.778811059434, 4445.73325600465, 4480.820767169277, 4485.9775701121935, 4496.662750293675, 4676.672632915664, 4687.671862969628, 4688.484266730657, 4689.601383882408, 4725.621950243973, 4735.952640473552, 4772.928406073981, 4794.30482580017, 4864.537868902448, 4872.537108974641, 5125.92311115341, 5138.023775482647, 5141.151709967813, 5187.714675692873, 5192.870178245574, 4816.614670826255, 4817.084753896748, 4824.710517368969, 4844.903101937871, 4873.975630121827, 4871.610271178368, 4922.138625740409, 5051.722155281494, 5054.924176137288, 5110.3356563646485, 5106.795728170831, 5156.639035267495, 5165.9483405166975, 5181.3005244291535, 5234.0, 4770.570648641639, 4786.0, 4796.472388037243, 4815.590674792542, 4823.1800593898415, 4571.26859702446, 4585.72485650862, 4599.586037256529, 4695.976520117514, 4730.385049943486, 4718.3394324795245, 4791.113643975876, 4811.08589368019, 4831.589314908272, 4886.389201349832, 4952.232403977389, 4964.975175124101, 4967.0, 4980.8754781130765, 5031.245313203049, 4681.906361872675, 4848.854534363974, 4858.611311095033, 4861.829835955725, 4862.781174847069], "value": 4656.676231982946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.5779376498801, 548.5638917060936, 552.3344370034109, 552.5165480204821, 569.2173261765073, 28845.0, 31670.52494212586, 31767.36465270696, 38961.22077558447, 41123.0, 40519.79740101303, 40844.79577602115, 40854.38718419219, 40892.0, 40989.7950510247, 7610.733624323164, 7784.80537986552, 7785.182555831613, 7796.181400952875, 7844.1763614820475, 7580.810479737996, 7706.845863082735, 7776.0, 10039.397636141819, 10292.588296468133, 10069.0, 10079.748006299827, 10095.798084038315, 10169.644062457815, 10240.846387304196, 9960.402375857435, 9972.703548538717, 10004.59981600735, 10018.89981100187, 10034.096931276184, 9818.410895346302, 9923.106920377128, 9931.70204893847, 9933.056359645821, 9941.850872236922, 38613.61386386128, 38669.0, 38702.80648596739, 38787.41818872719, 38871.61128388708, 3435.6220815710503, 3516.859325626972, 3534.469829525566, 3548.3258180945536, 3553.378158822222, 27509.587356189673, 27808.721912781017, 28271.85864070687, 28275.0, 28341.57487637687, 3468.791872487659, 3482.4776283557417, 3576.946345804815, 3589.264200838848, 3647.471116688065, 232265.0, 232762.9999999983, 234167.0, 234670.0, 234779.0, 52198.739006305485, 52278.738606306724, 52303.108471559164, 52423.73788131111, 52957.47042529525, 56048.719756400955, 56308.43691563114, 56367.71816140975, 56397.43602564004, 56495.71752141213, 13910.374033168531, 14514.564563063124, 14528.709425811425, 14531.78202326966, 14533.78199327011, 9827.656032038843, 10803.081738052353, 10997.890021099687, 10998.615048473264, 10999.450027498593, 13913.234772087633, 15436.691266174837, 15895.841041589436, 15915.0, 16094.75857862133, 5974.163617093611, 5986.2517185351835, 6007.15899774032, 6097.237845269341, 6125.816225513242, 742.8068702137483, 793.4485532554819, 799.5083023940235, 805.6414895371504, 810.3071873548149, 27475.17574472769, 28015.0, 28457.430851382855, 28838.567421488693, 28930.42139157205, 807.0073809214582, 903.9276857851356, 906.3293163059288, 907.419251678926, 913.992963151225, 12898.419571119322, 13189.0, 13535.796963045563, 13559.932200338935, 13566.728665426834, 351316.0, 351884.0, 352935.0, 353001.0, 353898.0, 44142.33786493205, 44332.77833610876, 44345.334819977725, 44360.77819610881, 44399.112017759464, 1156.3986726901796, 1197.7963746163, 1217.6407959651747, 1218.9817152742717, 1219.7316590350108, 22770.20304289342, 22823.543529129656, 24250.63624045676, 24270.393240168432, 24395.878020610493, 35571.82214088913, 36915.63084369229, 36979.630203698696, 36994.44508332431, 37000.81499592485, 303210.0, 303971.0, 304345.0, 305758.0, 305871.0, 20963.371098867057, 21106.251093503837, 23346.883265583565, 23354.18260360879, 23360.18239361614, 30039.3992120152, 35584.46623300704, 39873.80063099666, 40569.90026745249, 40759.59240407558, 31203.68796312008, 31552.84223578959, 31863.0, 31874.362512750078, 32814.17964550905, 32083.839580801945, 32203.838980804947, 32215.0, 32547.674523254464, 32562.837185813918, 28813.96604475333, 29089.563656544746, 29128.0, 32124.753625490554, 32393.838030809697, 26194.0, 29076.854615726785, 29148.7085129146, 29207.707922920497, 29474.852625736734, 22532.0, 22931.78954946342, 23305.533889321778, 24837.379065523506, 24944.750552494243], "value": 16919.27776768769, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.30682475996565, 357.89621009907125, 362.535953978907, 366.9981650091749, 380.07072707230816, 16289.83710162898, 17054.573635659082, 17580.47258582243, 17621.559461013465, 17740.112994350264, 16051.91974040131, 16826.747598785998, 16832.24254908529, 16992.0, 17052.573685657866, 4867.440244371898, 5096.4648711885275, 5108.846734597968, 5117.692938423706, 5120.769565369549, 3892.5134358205223, 4085.5710150434224, 5004.049230646184, 5697.886042279152, 5978.611390259619, 5976.8505787355225, 5981.252343457068, 5990.760369585211, 6063.727132279036, 6078.17944577483, 5707.77168913243, 5892.823215303569, 5924.14099955504, 5994.520438364964, 6011.699415029275, 5050.419201791804, 5253.737313134328, 5257.211418287249, 5259.894802103937, 5260.815871444519, 20980.475488112766, 21096.578068438546, 21332.893335533223, 21386.0, 21438.24966126178, 2179.564087182554, 2216.36833502451, 2231.7991380775647, 2251.4033781048033, 2283.8515496492673, 13280.734385312337, 13334.933325333312, 13711.862881371258, 13774.380152893144, 14087.929560352133, 1726.9568260793455, 1737.5829800847832, 1739.3042782886946, 1750.1861634339966, 1760.3398725477946, 75695.0, 76507.23492765112, 77990.61004694997, 78259.21740782577, 80161.0, 9548.474833884204, 9765.0, 9807.31348805591, 9897.109260166619, 9915.553800079013, 12821.423035963404, 13150.473981040843, 13172.538961136313, 13185.142965707199, 13188.208707477583, 7143.699394701724, 7157.105361829771, 7291.416686665054, 7307.232740562271, 7390.630468476555, 6840.863182736317, 6901.792946211622, 7034.718611255595, 7114.71541138359, 7121.750738724119, 6141.6007959482495, 6284.4344009039405, 6318.936810631927, 6374.330695277022, 6399.616023038632, 1624.5045261195212, 1647.8187399386297, 1708.5813975575816, 1717.2615775216527, 1763.1360633289596, 789.6051974012994, 795.7175202803037, 801.7875263055295, 805.6374631415887, 828.2462958707547, 17289.654206916042, 17399.47801565955, 17925.46223613294, 18064.81935180658, 18579.44261672125, 807.1363640904293, 809.4455298120806, 819.7540737778643, 825.1995564302617, 829.3282441222628, 9056.0, 10021.39871607706, 10092.343997640277, 10174.13519850821, 10210.234232432449, 220434.0, 221818.0, 222161.0, 373059.0, 376867.0, 91289.0, 94158.52920735352, 95508.0, 96530.51734741281, 96536.51731741296, 903.1961554216753, 946.2477330522252, 951.8524628682427, 958.5399008475831, 959.2374062620233, 15313.310901009258, 15460.072395656296, 15670.843291566938, 15700.921495392908, 16178.757318640466, 35503.28993420066, 35596.82201588975, 37006.814965925, 40058.39912401258, 40830.183396332504, 50020.49979500158, 54504.0, 54680.0, 55957.0, 56781.0, 7839.490433121829, 7874.606269686607, 8033.55815430157, 8057.153998830273, 8083.514989100673, 11806.763864722829, 12263.26420414778, 12342.13605047638, 12738.235705857678, 12761.74476510446, 10124.088832005154, 10346.844797327896, 10520.526576304237, 10686.412247326472, 11055.94472027667, 10700.913321902155, 10758.13934885223, 10770.73073173177, 10890.23768336209, 10952.616658416917, 9897.802043959224, 9999.35004224723, 10777.515011824644, 10995.890041099807, 11251.606193783178, 7868.763937081897, 7917.0, 7946.086200087064, 8039.959800200962, 8199.385046121684, 10074.14369778577, 10483.47582620881, 10567.471626418495, 10672.199585030998, 10748.301360411548], "value": 8497.464139832295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.4617537546546, 1276.2916581297388, 1276.5532063777675, 1277.827493288406, 1288.3622606809631, 6319.462845658119, 6700.128983232185, 6712.295209003051, 6714.496412769037, 6728.058071869942, 5575.470330318623, 5784.797532086378, 6261.0, 6520.869582608345, 6544.312847151052, 1993.7308463357442, 2052.0150327842643, 2058.577991511744, 2065.2048961149917, 2074.1081335025933, 2024.8076432738867, 2053.58928214357, 2055.7122002919605, 2090.25795842476, 2091.362134548962, 1755.8419742223198, 1810.9909450452728, 1822.562584979602, 1824.644194382096, 1833.294181740033, 1973.289615738333, 2034.257496013959, 2038.1745393115812, 2050.2516581447812, 2053.435305291042, 2063.566651003291, 2070.3995841206033, 2090.4669309326177, 2096.088201632295, 2096.2139197800825, 6514.609123452608, 6562.967185164043, 6578.440832529241, 6632.63520506372, 6649.235337936103, 4062.5734297898885, 4178.623923846869, 4180.268453020709, 4180.372944058385, 4180.728252663567, 2619.292790946434, 2674.3314171457137, 2712.4846279207086, 2757.54500507416, 2758.2690586994263, 1027.9557367501486, 1039.2413538117141, 1075.7794652096302, 1076.8438576406456, 1091.2143256855052, 8510.74467765968, 8594.441361311494, 8599.226069653761, 8611.741647750514, 8626.870596941051, 3557.6442355764216, 3728.8508459661853, 3735.7945313008045, 3772.5095737553943, 3779.130799916035, 7537.849243015109, 7552.282533159341, 7570.810729731801, 7574.3183113520045, 7592.126905405949, 4179.414881916534, 4180.393842892763, 4181.91636167281, 4181.97909010453, 4183.686223533186, 3763.096856754414, 3824.254270417242, 3883.0292426893275, 3884.1843212925037, 3889.0471834400755, 3218.613766348053, 3260.739140868725, 3261.8471808606205, 3277.524758909945, 3342.5821772278464, 1078.5685725709623, 1079.9730006749737, 1084.9476008271963, 1093.191038631407, 1095.3482677806692, 576.5531712922435, 673.8147009572407, 780.574586850168, 803.6022169026253, 807.1726480357563, 4243.681723870722, 4577.29051996941, 4579.198640237945, 4643.326717625925, 4714.269288260325, 485.0517238798141, 489.3467221259587, 492.3107649291021, 492.68221996811855, 610.2311088029027, 3010.1722026442903, 3234.4178047951123, 3244.8864289749745, 3276.4430046892085, 3354.0608629583758, 7501.587412692245, 7678.846423071507, 7799.766007019798, 7805.102413222438, 7806.68773249075, 7716.884246736304, 7738.458307918504, 7739.922600774033, 7759.7672069838, 7760.262775036363, 6158.784442544489, 6166.660833654192, 6250.656213908188, 6277.5605707600025, 6323.146375239284, 4410.977945110254, 4435.977820110878, 4512.526184750685, 4532.093581283691, 4622.2835460503675, 7161.749338773118, 7175.461840362098, 7176.138863336224, 7266.818329541804, 7305.050343455317, 7287.307705767944, 7303.488755787044, 7316.561006339423, 7400.444966627632, 7411.4070874328845, 5726.885462290814, 5837.357890631942, 5935.673537955454, 6034.487068599218, 6044.576879618385, 6415.454686351713, 6457.870842583028, 6474.320196379313, 6480.54636175482, 6480.837979050561, 5840.2115714378015, 5899.085641725539, 5908.645481271137, 5915.349311575809, 6062.151298818258, 5857.0, 5857.5313974881055, 5872.588918775645, 5900.616459930091, 5911.852203694942, 5100.668456550312, 5180.378354597472, 5180.6891586504935, 5181.119209734279, 5181.2746215529105, 3923.2349691809823, 3965.1276719121747, 4016.678665706795, 4026.7382620129597, 4140.648044916095, 3988.5213774346103, 4028.91942161161, 4032.5362583303295, 4076.2458945095254, 4162.937555936724], "value": 3594.179177235491, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.3333333333333, 338.47198370541946, 345.97059249963735, 346.12948434686757, 348.491202843848, 4858.5627293543575, 4915.852524424264, 4920.557149856512, 4926.546668732723, 4938.950610493894, 4846.497585748411, 4868.391451068616, 4872.70763754175, 4877.292792545079, 4911.8211629209, 3665.211979424423, 3790.829412676422, 3832.5400951885813, 3851.42228665701, 3879.1465877506903, 3834.5206849143856, 3877.515310586177, 3907.960920390802, 3915.9021024474473, 3917.5886531914166, 3836.405357169629, 3845.3270677631444, 3856.190200057991, 3871.7676939383728, 3877.6316249956208, 3703.9629603704157, 3787.299349620329, 3832.367659336206, 3873.9031524211837, 3885.785102491581, 3424.178197232671, 3446.551948246737, 3452.8273586320583, 3461.930761384758, 3469.340825243196, 4692.859214223545, 4749.810007599692, 4755.500672429414, 4759.0, 4783.856484305476, 4321.567843215685, 4421.9115617687785, 4436.201483732927, 4436.889077773049, 4437.2013037653205, 5042.184813467149, 5089.440161582223, 5097.337346144977, 5097.592192624581, 5105.770240339194, 3771.264603402338, 3784.280986612535, 3792.5448946126367, 3795.0, 3801.6958643308744, 5166.250893620404, 5379.273798037293, 5390.326209223847, 5399.0, 5427.864303392407, 3858.479105320746, 3876.825542850522, 3884.320243957353, 3893.014562573108, 3893.8053097345587, 3940.9211815763524, 3942.955116894025, 3954.8220330085214, 3956.5647778744315, 3969.900752481211, 4429.446319210098, 4448.799804008828, 4460.933086003713, 4461.709988850779, 4462.196804575207, 5017.473165317662, 5069.797208111708, 5099.87250318745, 5123.8719032023755, 5192.584593232608, 1311.2001678975817, 1311.9803202951964, 1325.7414804113105, 1328.940197691087, 1330.3015916643647, 914.8170365926841, 950.4107453378949, 954.3128947158035, 971.4899677669139, 972.2999440402899, 4225.7887105644595, 4355.934660980088, 4368.934465983013, 4528.320751887178, 4535.138323718483, 5256.894862102737, 5265.420803711589, 5272.841814745564, 5282.392524859613, 5284.9471505284455, 4502.324651302265, 4504.990558403024, 4505.391772110723, 4535.9773201133785, 4551.338761352083, 2557.7314381989995, 2676.3978104926236, 2691.4347986922576, 2703.580620174385, 2704.7287774745837, 4803.022126281658, 4811.3745213122775, 4814.253790662453, 4816.325714399917, 4822.71063736177, 5035.571976381975, 5122.948770512247, 5137.460566640524, 5193.610479214074, 5195.48045195485, 4746.359241502353, 4795.472498025214, 4809.615230781599, 4816.710997340101, 4836.903261934742, 5069.569086627531, 5089.211172268304, 5135.820246291362, 5154.5824898153305, 5159.561437277874, 4926.556609905126, 5080.796768129233, 5086.720230387365, 5086.847394578169, 5091.1854103343285, 4928.630352723489, 4937.185364414831, 4956.925646115239, 4962.33008543842, 4970.304157418037, 3652.9634703653687, 3681.5398075240596, 3707.4068149096015, 3715.479832823461, 3719.9070023249637, 5139.177731562932, 5355.22349259363, 5355.973220133875, 5369.140937449989, 5375.784968601369, 4893.9021219576125, 4909.779059942382, 4913.140200464833, 4913.420454261542, 4954.405471343462, 4864.148773964613, 4869.853904382874, 4881.9023619528125, 4907.214845624683, 4910.558049775537, 4725.29120631908, 4920.286558449076, 4945.431275403231, 4951.752412379295, 4956.686478083383, 4829.855104346875, 4929.260610908393, 4936.259561065869, 5032.370953630796, 5048.242763585492, 4911.361523001987, 4915.729634870117, 4920.6555541111775, 4927.18701414277, 4928.334674818997], "value": 3867.804964921851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.9768009279629, 599.9760009599617, 655.8983357579575, 660.9471242300615, 670.6345041952136, 11337.979581837633, 12289.877101228985, 12526.686832829173, 13262.137961032526, 13410.262435566065, 13990.090644108152, 14142.505012324571, 14175.668717851297, 14309.212993285366, 15000.924995375035, 798.9520628762264, 814.2793627639522, 818.6848063495568, 819.0253598218131, 820.0528389709895, 667.3860048755157, 685.8971154326841, 792.1049214387763, 810.2626609785067, 811.4401063266328, 861.5562985062697, 863.3266052479045, 864.1229152410277, 865.5845194306737, 865.6580650642992, 852.9977276699852, 853.1596377568121, 853.6158728572105, 854.1671869926834, 856.6359297298624, 517.7902949305537, 531.9920201196985, 606.2270604978644, 620.9658468784215, 632.996835015822, 12090.09324300681, 12090.455929483194, 12131.029517638568, 12136.635900922987, 12140.45367958444, 12307.507699692002, 12547.93726031364, 12629.557965471256, 12719.427625756864, 12872.16330938486, 12149.271043737404, 12159.600997506235, 12180.451879665348, 12283.0, 12426.192297500633, 4035.3946907963746, 4069.0844559974066, 4070.450489183952, 4107.424960505532, 4146.958530414688, 62587.0, 63448.68275658592, 63478.36521634817, 64197.358026419606, 64578.0, 10062.748431289276, 10064.144547713526, 10201.744956376002, 10233.641822536176, 10345.689629311133, 17769.7334539982, 18433.723494147598, 18702.812971870106, 19719.309824156087, 19721.211151554064, 6667.0, 6744.898826517508, 6779.694913728894, 6830.385265326145, 6905.551139175937, 3531.205478767257, 3550.6626870447267, 3577.624349443271, 3594.119440736984, 3628.8367023484006, 2870.468963241807, 2929.5019846626124, 2940.0444855421647, 2968.139239620486, 2970.9257268568026, 490.6712502623251, 495.10880415252404, 495.55895253224656, 495.58370968386726, 498.16308601549747, 615.7752420366534, 627.4071002902214, 629.2040568680623, 632.2665707778955, 646.1535388640896, 6943.72225111, 7167.749128780468, 7691.115521714963, 7754.108277548042, 7927.643256053491, 591.8872519663006, 607.9817605471843, 613.6471528870828, 617.9660118693515, 622.5922021076202, 3701.11173318407, 3804.0, 3813.2182902505474, 3816.6183381661613, 3845.6731177850197, 53030.73484632629, 53765.0, 53854.46145538573, 59339.0, 66731.0, 46179.76910115428, 47221.0, 48256.5174348259, 59070.40929590735, 59304.0, 47389.526104738514, 48272.75863620659, 48971.26543101856, 49160.50839491631, 52357.7382113087, 8238.629261683358, 8348.749537513884, 8431.704890328809, 8512.543465608229, 8661.480311181349, 34961.30077398387, 35336.82331588326, 35421.291574168885, 35810.64189358177, 37104.0, 40994.1801163981, 42609.78695106505, 43042.56957430386, 43577.56422435735, 44967.55032449633, 11245.123795876072, 11476.770464590494, 11579.536818527165, 11669.183157178915, 11962.58130965412, 12478.937605311916, 12522.624321270376, 12718.236905785683, 12803.423845927142, 13254.204747715168, 12079.858979183598, 12253.529576450883, 12515.311657858905, 12627.873721263037, 12932.640210133999, 11116.277441966246, 11242.775144497227, 11321.0, 11321.377324246916, 11916.469825046095, 11131.610393636183, 11136.554537818396, 11460.656180314603, 11626.128040397174, 11844.0, 9232.630694772133, 9355.532223388667, 9361.625534978524, 9444.244460443286, 9598.32811703174, 8892.0, 9115.589798459217, 9245.121713437213, 9272.304577156605, 9371.906280937375], "value": 6243.906029829516, "unit": "score"}], "name": "dromaeo_css", "value": 6223.771574574197, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 116.0, 116.0, 114.0, 115.0, 115.0, 114.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 127.0, 180.0, 133.0, 134.0, 127.0, 126.0, 152.0, 128.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 163.0, 164.0, 163.0, 162.0, 164.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 130.0, 77.0, 78.0, 77.0, 77.0, 94.0, 78.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 109.0, 84.0, 85.0, 85.0, 110.0, 86.0, 85.0, 112.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 150.0, 149.0, 149.0, 150.0, 150.0, 148.0, 151.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 97.0, 96.0, 95.0, 97.0, 95.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 64.0, 62.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 69.0, 67.0, 68.0, 67.0, 67.0, 68.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 94.0, 88.0, 96.0, 85.0, 84.0, 93.0, 85.0, 85.0, 85.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 134.0, 134.0, 131.0, 132.0, 146.0, 132.0, 231.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 180.0, 185.0, 179.0, 181.0, 180.0, 188.0, 179.0, 178.0, 178.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 68.0, 71.0, 69.0, 68.0, 67.0, 66.0, 68.0, 67.0, 67.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1569.8000000000002, "alertThreshold": 2.0}]} 19:20:49 INFO - Return code: 0 19:20:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:20:49 INFO - # TBPL SUCCESS # 19:20:49 INFO - Running post-action listener: _resource_record_post_action 19:20:49 INFO - [mozharness: 2017-01-05 03:20:49.080964Z] Finished run-tests step (success) 19:20:49 INFO - Running post-run listener: _resource_record_post_run 19:20:49 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406257664; Read time: 4; Write time: 298976 19:20:49 INFO - TinderboxPrint: CPU usage
13.1% 19:20:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 19:20:49 INFO - TinderboxPrint: I/O write bytes / time
406,257,664 / 298,976 19:20:49 INFO - TinderboxPrint: CPU idle
8,334.1 (86.9%) 19:20:49 INFO - TinderboxPrint: CPU user
1,213.2 (12.6%) 19:20:49 INFO - TinderboxPrint: Swap in / out
0 / 0 19:20:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99414016; Read time: 0; Write time: 96184 19:20:49 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 294940672; Read time: 0; Write time: 200992 19:20:49 INFO - Running post-run listener: _upload_blobber_files 19:20:49 INFO - Blob upload gear active. 19:20:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:49 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 19:20:49 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'] 19:20:49 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 19:20:50 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:20:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:20:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:53 INFO - (blobuploader) - INFO - Done attempting. 19:20:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:20:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:20:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:54 INFO - (blobuploader) - INFO - Done attempting. 19:20:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:20:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:20:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:55 INFO - (blobuploader) - INFO - Done attempting. 19:20:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:20:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:20:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:56 INFO - (blobuploader) - INFO - Done attempting. 19:20:56 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:56 INFO - Return code: 0 19:20:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/241a0fea631b69dace14f1bcaba05077d9cbf3ddd7c627763079cd45e3c9f2efd290e53f209d138de1ad28e00a9ed2c7b67b503fa7d1be619168fa2752eb7791", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f085066e279f8a9a0de2f4bec01cc486cae6025250365f98b11ce0958ff0af1e8a139f4eb719a1761cc391b2f96df682889f7ce20feccb389a3e1eb259bbc183", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef93d869a5f762547254dc279b692c1ec047fe5b0261fa74d36018c49c4a04d3ffe03ce5584276fa9a5d20643a6c5eac1e8b1e323d44b5ddd1bf058309aac3a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd29b16359893b5ced5dbfbbcb225054ff0ddd77da3e452321e373ae8b7fd5849791610ee6be6b875afec837924d9388702eca5a008fb1b90e8f6d62c8f93ee4"} 19:20:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:56 INFO - Contents: 19:20:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/241a0fea631b69dace14f1bcaba05077d9cbf3ddd7c627763079cd45e3c9f2efd290e53f209d138de1ad28e00a9ed2c7b67b503fa7d1be619168fa2752eb7791", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f085066e279f8a9a0de2f4bec01cc486cae6025250365f98b11ce0958ff0af1e8a139f4eb719a1761cc391b2f96df682889f7ce20feccb389a3e1eb259bbc183", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef93d869a5f762547254dc279b692c1ec047fe5b0261fa74d36018c49c4a04d3ffe03ce5584276fa9a5d20643a6c5eac1e8b1e323d44b5ddd1bf058309aac3a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd29b16359893b5ced5dbfbbcb225054ff0ddd77da3e452321e373ae8b7fd5849791610ee6be6b875afec837924d9388702eca5a008fb1b90e8f6d62c8f93ee4"} 19:20:56 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:56 INFO - Copying logs to upload dir... 19:20:56 INFO - mkdir: /builds/slave/test/build/upload/logs 19:20:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.098782 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-04 19:20:56.717357) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 19:20:56.721139) ========= 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=52faae308a556c440401f8e5000001e8-1483582836.869440-988595144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/241a0fea631b69dace14f1bcaba05077d9cbf3ddd7c627763079cd45e3c9f2efd290e53f209d138de1ad28e00a9ed2c7b67b503fa7d1be619168fa2752eb7791", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f085066e279f8a9a0de2f4bec01cc486cae6025250365f98b11ce0958ff0af1e8a139f4eb719a1761cc391b2f96df682889f7ce20feccb389a3e1eb259bbc183", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef93d869a5f762547254dc279b692c1ec047fe5b0261fa74d36018c49c4a04d3ffe03ce5584276fa9a5d20643a6c5eac1e8b1e323d44b5ddd1bf058309aac3a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd29b16359893b5ced5dbfbbcb225054ff0ddd77da3e452321e373ae8b7fd5849791610ee6be6b875afec837924d9388702eca5a008fb1b90e8f6d62c8f93ee4"} build_url:https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011736 build_url: 'https://queue.taskcluster.net/v1/task/OASrlaYCTQqM0wWf-2A0cQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/241a0fea631b69dace14f1bcaba05077d9cbf3ddd7c627763079cd45e3c9f2efd290e53f209d138de1ad28e00a9ed2c7b67b503fa7d1be619168fa2752eb7791", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f085066e279f8a9a0de2f4bec01cc486cae6025250365f98b11ce0958ff0af1e8a139f4eb719a1761cc391b2f96df682889f7ce20feccb389a3e1eb259bbc183", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef93d869a5f762547254dc279b692c1ec047fe5b0261fa74d36018c49c4a04d3ffe03ce5584276fa9a5d20643a6c5eac1e8b1e323d44b5ddd1bf058309aac3a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd29b16359893b5ced5dbfbbcb225054ff0ddd77da3e452321e373ae8b7fd5849791610ee6be6b875afec837924d9388702eca5a008fb1b90e8f6d62c8f93ee4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 19:20:56.747177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:20:56.747525) ========= 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=52faae308a556c440401f8e5000001e8-1483582836.869440-988595144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:20:56.833499) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 19:20:56.833939) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 19:20:56.834295) ========= ========= Total master_lag: 0.17 =========