builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1485844905.11 results: success (0) revision: 9c06e744b1befb3a2e2fdac7414ce18220774a1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:45.114556) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:45.115065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:45.115397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:45.135275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:45.135620) ========= 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=20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-30 22:41:45-- 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% 224M=0s 2017-01-30 22:41:45 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137250 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:45.286796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:45.287307) ========= 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=20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014687 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:45.337773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:45.338205) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9c06e744b1befb3a2e2fdac7414ce18220774a1d --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 9c06e744b1befb3a2e2fdac7414ce18220774a1d --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=20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-30 22:41:45,440 truncating revision to first 12 chars 2017-01-30 22:41:45,440 Setting DEBUG logging. 2017-01-30 22:41:45,440 attempt 1/10 2017-01-30 22:41:45,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9c06e744b1be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 22:41:46,082 unpacking tar archive at: mozilla-central-9c06e744b1be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.908757 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:46.263142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:46.263503) ========= script_repo_revision: 9c06e744b1befb3a2e2fdac7414ce18220774a1d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:46.263917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:46.264231) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 22:41:46.276964) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-01-30 22:41:46.277348) ========= /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=20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:41:46 INFO - MultiFileLogger online at 20170130 22:41:46 in /builds/slave/test 22:41:46 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 22:41:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:41:46 INFO - {'append_to_log': False, 22:41:46 INFO - 'base_work_dir': '/builds/slave/test', 22:41:46 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:41:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:41:46 INFO - 'branch': 'Firefox-Non-PGO', 22:41:46 INFO - 'buildbot_json_path': 'buildprops.json', 22:41:46 INFO - 'config_files': ('talos/linux_config.py',), 22:41:46 INFO - 'default_actions': ('clobber', 22:41:46 INFO - 'read-buildbot-config', 22:41:46 INFO - 'download-and-extract', 22:41:46 INFO - 'populate-webroot', 22:41:46 INFO - 'create-virtualenv', 22:41:46 INFO - 'install', 22:41:46 INFO - 'run-tests'), 22:41:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:41:46 INFO - 'download_minidump_stackwalk': True, 22:41:46 INFO - 'download_symbols': 'ondemand', 22:41:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:41:46 INFO - 'tooltool.py': '/tools/tooltool.py', 22:41:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:41:46 INFO - '/tools/misc-python/virtualenv.py')}, 22:41:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:41:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:41:46 INFO - 'installer_path': 'installer.exe', 22:41:46 INFO - 'log_level': 'info', 22:41:46 INFO - 'log_name': 'talos', 22:41:46 INFO - 'log_to_console': True, 22:41:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:41:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:41:46 INFO - 'opt_config_files': (), 22:41:46 INFO - 'pip_index': False, 22:41:46 INFO - 'sps_profile': False, 22:41:46 INFO - 'sps_profile_interval': 0, 22:41:46 INFO - 'suite': 'dromaeojs', 22:41:46 INFO - 'system_bits': '32', 22:41:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:41:46 INFO - 'title': 'talos-linux64-ix-015', 22:41:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:41:46 INFO - 'use_talos_json': True, 22:41:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:41:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:41:46 INFO - 'work_dir': 'build'} 22:41:46 INFO - [mozharness: 2017-01-31 06:41:46.479688Z] Running clobber step. 22:41:46 INFO - Running pre-action listener: _resource_record_pre_action 22:41:46 INFO - Running main action method: clobber 22:41:46 INFO - rmtree: /builds/slave/test/build 22:41:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:41:47 INFO - Running post-action listener: _resource_record_post_action 22:41:47 INFO - [mozharness: 2017-01-31 06:41:47.444608Z] Finished clobber step (success) 22:41:47 INFO - [mozharness: 2017-01-31 06:41:47.444707Z] Running read-buildbot-config step. 22:41:47 INFO - Running pre-action listener: _resource_record_pre_action 22:41:47 INFO - Running main action method: read_buildbot_config 22:41:47 INFO - Using buildbot properties: 22:41:47 INFO - { 22:41:47 INFO - "project": "", 22:41:47 INFO - "product": "firefox", 22:41:47 INFO - "who": "philringnalda@gmail.com", 22:41:47 INFO - "installer_path": "public/build/target.tar.bz2", 22:41:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:41:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:41:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 22:41:47 INFO - "stage_platform": "linux64", 22:41:47 INFO - "basedir": "/builds/slave/test", 22:41:47 INFO - "buildnumber": 809, 22:41:47 INFO - "platform": "ubuntu64_hw", 22:41:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:41:47 INFO - "slavebuilddir": "test", 22:41:47 INFO - "taskId": "TJMA33yBTyyHlXxjwxUAWQ", 22:41:47 INFO - "branch": "mozilla-central", 22:41:47 INFO - "script_repo_revision": "production", 22:41:47 INFO - "revision": "9c06e744b1befb3a2e2fdac7414ce18220774a1d", 22:41:47 INFO - "slavename": "talos-linux64-ix-015", 22:41:47 INFO - "repo_path": "mozilla-central" 22:41:47 INFO - } 22:41:47 INFO - Finding installer, test and symbols from parent task. 22:41:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJMA33yBTyyHlXxjwxUAWQ'}, attempt #1 22:41:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJMA33yBTyyHlXxjwxUAWQ'}, attempt #1 22:41:48 INFO - Task dependencies: RgKIY3DMSXeFHtu3mjvffw 22:41:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw'}, attempt #1 22:41:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.tar.bz2 22:41:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/test_packages.json 22:41:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.crashreporter-symbols.zip 22:41:48 INFO - Running post-action listener: _resource_record_post_action 22:41:48 INFO - [mozharness: 2017-01-31 06:41:48.850173Z] Finished read-buildbot-config step (success) 22:41:48 INFO - [mozharness: 2017-01-31 06:41:48.850394Z] Running download-and-extract step. 22:41:48 INFO - Running pre-action listener: _resource_record_pre_action 22:41:48 INFO - Running main action method: download_and_extract 22:41:48 INFO - mkdir: /builds/slave/test/build/tests 22:41:48 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')]} 22:41:48 INFO - trying https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.test_packages.json 22:41:48 INFO - Downloading https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:41:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:41:49 INFO - Downloaded 896 bytes. 22:41:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:41:49 INFO - Using the following test package requirements: 22:41:49 INFO - {u'common': [u'target.common.tests.zip'], 22:41:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:41:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:41:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:41:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:41:49 INFO - u'mozbase': [u'target.common.tests.zip'], 22:41:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:41:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:41:49 INFO - u'web-platform': [u'target.common.tests.zip', 22:41:49 INFO - u'target.web-platform.tests.zip'], 22:41:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:41:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:41:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.common.tests.zip 22:41:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:41:49 INFO - Fetch https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.common.tests.zip into memory 22:41:50 INFO - Expected file size: 20336357 22:41:50 INFO - Obtained file size: 20336357 22:41:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:41:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.common.tests.zip 22:41:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:41:54 INFO - Fetch https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.common.tests.zip into memory 22:41:55 INFO - Expected file size: 20336357 22:41:55 INFO - Obtained file size: 20336357 22:41:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.talos.tests.zip 22:41:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:41:59 INFO - Fetch https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.talos.tests.zip into memory 22:42:00 INFO - Expected file size: 14403454 22:42:00 INFO - Obtained file size: 14403454 22:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:00 INFO - trying https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.tar.bz2 22:42:00 INFO - Downloading https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:42:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:42:01 INFO - Downloaded 56231249 bytes. 22:42:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.tar.bz2 22:42:01 INFO - mkdir: /builds/slave/test/properties 22:42:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:42:01 INFO - Writing to file /builds/slave/test/properties/build_url 22:42:01 INFO - Contents: 22:42:01 INFO - build_url:https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.tar.bz2 22:42:01 INFO - Running post-action listener: _resource_record_post_action 22:42:01 INFO - Running post-action listener: set_extra_try_arguments 22:42:01 INFO - [mozharness: 2017-01-31 06:42:01.523007Z] Finished download-and-extract step (success) 22:42:01 INFO - [mozharness: 2017-01-31 06:42:01.523104Z] Running populate-webroot step. 22:42:01 INFO - Running pre-action listener: _resource_record_pre_action 22:42:01 INFO - Running main action method: populate_webroot 22:42:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:42:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:42:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:42:01 INFO - '--tppagecycles', 22:42:01 INFO - '7'], 22:42:01 INFO - 'tests': ['tsvgm']}}, 22:42:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:42:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:42:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:42:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:42:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:42:01 INFO - 'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:42:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:42:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:42:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:42:01 INFO - 'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['damp', 'tps']}, 22:42:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:42:01 INFO - 'tests': ['damp', 'tps']}, 22:42:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['dromaeo_dom']}, 22:42:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:42:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['basic_compositor_video']}, 22:42:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:42:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['a11yr', 22:42:01 INFO - 'ts_paint', 22:42:01 INFO - 'tpaint', 22:42:01 INFO - 'sessionrestore', 22:42:01 INFO - 'sessionrestore_no_auto_restore', 22:42:01 INFO - 'tabpaint']}, 22:42:01 INFO - 'other-e10s': {'tests': ['a11yr', 22:42:01 INFO - 'ts_paint', 22:42:01 INFO - 'tpaint', 22:42:01 INFO - 'sessionrestore', 22:42:01 INFO - 'sessionrestore_no_auto_restore', 22:42:01 INFO - 'tabpaint']}, 22:42:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:42:01 INFO - 'ts_paint', 22:42:01 INFO - 'tpaint', 22:42:01 INFO - 'sessionrestore', 22:42:01 INFO - 'sessionrestore_no_auto_restore', 22:42:01 INFO - 'tabpaint']}, 22:42:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:42:01 INFO - 'ts_paint', 22:42:01 INFO - 'tpaint', 22:42:01 INFO - 'sessionrestore', 22:42:01 INFO - 'sessionrestore_no_auto_restore', 22:42:01 INFO - 'tabpaint']}, 22:42:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['a11yr', 22:42:01 INFO - 'ts_paint', 22:42:01 INFO - 'tpaint', 22:42:01 INFO - 'sessionrestore', 22:42:01 INFO - 'sessionrestore_no_auto_restore', 22:42:01 INFO - 'tabpaint']}, 22:42:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['a11yr', 22:42:01 INFO - 'ts_paint', 22:42:01 INFO - 'tpaint', 22:42:01 INFO - 'sessionrestore', 22:42:01 INFO - 'sessionrestore_no_auto_restore', 22:42:01 INFO - 'tabpaint']}, 22:42:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['tsvgx', 22:42:01 INFO - 'tsvgr_opacity', 22:42:01 INFO - 'tart', 22:42:01 INFO - 'tscrollx', 22:42:01 INFO - 'cart', 22:42:01 INFO - 'tsvg_static']}, 22:42:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:42:01 INFO - 'tsvgr_opacity', 22:42:01 INFO - 'tart', 22:42:01 INFO - 'tscrollx', 22:42:01 INFO - 'cart', 22:42:01 INFO - 'tsvg_static']}, 22:42:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:42:01 INFO - 'talos_options': ['--disable-e10s'], 22:42:01 INFO - 'tests': ['tp5o']}, 22:42:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:42:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:42:01 INFO - 'talos_options': ['--disable-e10s', 22:42:01 INFO - '--xperf_path', 22:42:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:42:01 INFO - 'tests': ['tp5n']}, 22:42:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:42:01 INFO - 'talos_options': ['--xperf_path', 22:42:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:42:01 INFO - 'tests': ['tp5n']}}, 22:42:01 INFO - 'talos.zip': {'path': '', 22:42:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:42:01 INFO - Running post-action listener: _resource_record_post_action 22:42:01 INFO - [mozharness: 2017-01-31 06:42:01.536255Z] Finished populate-webroot step (success) 22:42:01 INFO - [mozharness: 2017-01-31 06:42:01.536348Z] Running create-virtualenv step. 22:42:01 INFO - Running pre-action listener: _resource_record_pre_action 22:42:01 INFO - Running main action method: create_virtualenv 22:42:01 INFO - Creating virtualenv /builds/slave/test/build/venv 22:42:01 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 22:42:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:42:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:42:01 INFO - Using real prefix '/usr' 22:42:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:42:02 INFO - Installing distribute.............................................................................................................................................................................................done. 22:42:04 INFO - Installing pip.................done. 22:42:04 INFO - Return code: 0 22:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:42:04 INFO - Reading from file tmpfile_stdout 22:42:04 INFO - Output received: 22:42:04 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) 22:42:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:04 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 0x17411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1851a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', '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 22:42:04 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 22:42:04 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 22:42:04 INFO - Using env: {'DISPLAY': ':0', 22:42:04 INFO - 'HOME': '/home/cltbld', 22:42:04 INFO - 'LANG': 'en_US.UTF-8', 22:42:04 INFO - 'LANGUAGE': 'en_US:en', 22:42:04 INFO - 'LOGNAME': 'cltbld', 22:42:04 INFO - 'MAIL': '/var/mail/cltbld', 22:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:04 INFO - 'MOZ_NO_REMOTE': '1', 22:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:04 INFO - 'NO_EM_RESTART': '1', 22:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:04 INFO - 'PWD': '/builds/slave/test', 22:42:04 INFO - 'SHELL': '/bin/bash', 22:42:04 INFO - 'SHLVL': '1', 22:42:04 INFO - 'TERM': 'linux', 22:42:04 INFO - 'TMOUT': '86400', 22:42:04 INFO - 'USER': 'cltbld', 22:42:04 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:04 INFO - '_': '/tools/buildbot/bin/python'} 22:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:04 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 22:42:04 INFO - Cleaning up... 22:42:04 INFO - Return code: 0 22:42:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:04 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 0x17411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1851a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', '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 22:42:04 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 22:42:04 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 22:42:04 INFO - Using env: {'DISPLAY': ':0', 22:42:04 INFO - 'HOME': '/home/cltbld', 22:42:04 INFO - 'LANG': 'en_US.UTF-8', 22:42:04 INFO - 'LANGUAGE': 'en_US:en', 22:42:04 INFO - 'LOGNAME': 'cltbld', 22:42:04 INFO - 'MAIL': '/var/mail/cltbld', 22:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:04 INFO - 'MOZ_NO_REMOTE': '1', 22:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:04 INFO - 'NO_EM_RESTART': '1', 22:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:04 INFO - 'PWD': '/builds/slave/test', 22:42:04 INFO - 'SHELL': '/bin/bash', 22:42:04 INFO - 'SHLVL': '1', 22:42:04 INFO - 'TERM': 'linux', 22:42:04 INFO - 'TMOUT': '86400', 22:42:04 INFO - 'USER': 'cltbld', 22:42:04 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:04 INFO - '_': '/tools/buildbot/bin/python'} 22:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:04 INFO - Downloading/unpacking psutil>=3.1.1 22:42:04 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 22:42:04 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 22:42:04 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 22:42:04 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 22:42:04 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 22:42:04 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 22:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:42:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:06 INFO - Installing collected packages: psutil 22:42:06 INFO - Running setup.py install for psutil 22:42:06 INFO - building 'psutil._psutil_linux' extension 22:42:06 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 22:42:07 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 22:42:07 INFO - building 'psutil._psutil_posix' extension 22:42:07 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 22:42:07 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 22:42:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:07 INFO - Successfully installed psutil 22:42:07 INFO - Cleaning up... 22:42:07 INFO - Return code: 0 22:42:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:42:07 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')]} 22:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:07 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')]} 22:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:07 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 0x17411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1851a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', '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 22:42:07 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 22:42:07 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 22:42:07 INFO - Using env: {'DISPLAY': ':0', 22:42:07 INFO - 'HOME': '/home/cltbld', 22:42:07 INFO - 'LANG': 'en_US.UTF-8', 22:42:07 INFO - 'LANGUAGE': 'en_US:en', 22:42:07 INFO - 'LOGNAME': 'cltbld', 22:42:07 INFO - 'MAIL': '/var/mail/cltbld', 22:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:07 INFO - 'MOZ_NO_REMOTE': '1', 22:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:07 INFO - 'NO_EM_RESTART': '1', 22:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:07 INFO - 'PWD': '/builds/slave/test', 22:42:07 INFO - 'SHELL': '/bin/bash', 22:42:07 INFO - 'SHLVL': '1', 22:42:07 INFO - 'TERM': 'linux', 22:42:07 INFO - 'TMOUT': '86400', 22:42:07 INFO - 'USER': 'cltbld', 22:42:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:07 INFO - '_': '/tools/buildbot/bin/python'} 22:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:42:07 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 22:42:07 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 22:42:07 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 22:42:07 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 22:42:07 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 22:42:07 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 22:42:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:42:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:42:09 INFO - Installing collected packages: mozsystemmonitor 22:42:09 INFO - Running setup.py install for mozsystemmonitor 22:42:09 INFO - Successfully installed mozsystemmonitor 22:42:09 INFO - Cleaning up... 22:42:09 INFO - Return code: 0 22:42:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1851a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', '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 22:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:42:09 INFO - Using env: {'DISPLAY': ':0', 22:42:09 INFO - 'HOME': '/home/cltbld', 22:42:09 INFO - 'LANG': 'en_US.UTF-8', 22:42:09 INFO - 'LANGUAGE': 'en_US:en', 22:42:09 INFO - 'LOGNAME': 'cltbld', 22:42:09 INFO - 'MAIL': '/var/mail/cltbld', 22:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:09 INFO - 'MOZ_NO_REMOTE': '1', 22:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:09 INFO - 'NO_EM_RESTART': '1', 22:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:09 INFO - 'PWD': '/builds/slave/test', 22:42:09 INFO - 'SHELL': '/bin/bash', 22:42:09 INFO - 'SHLVL': '1', 22:42:09 INFO - 'TERM': 'linux', 22:42:09 INFO - 'TMOUT': '86400', 22:42:09 INFO - 'USER': 'cltbld', 22:42:09 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:09 INFO - '_': '/tools/buildbot/bin/python'} 22:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:10 INFO - Downloading/unpacking jsonschema==2.5.1 22:42:10 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 22:42:10 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 22:42:10 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 22:42:10 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 22:42:10 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 22:42:10 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 22:42:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:42:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:12 INFO - Downloading functools32-3.2.3-2.tar.gz 22:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:42:12 INFO - warning: no files found matching '*.txt' 22:42:12 INFO - no previously-included directories found matching 'build' 22:42:12 INFO - no previously-included directories found matching 'dist' 22:42:12 INFO - no previously-included directories found matching '.git*' 22:42:12 INFO - Installing collected packages: jsonschema, functools32 22:42:12 INFO - Running setup.py install for functools32 22:42:12 INFO - warning: no files found matching '*.txt' 22:42:12 INFO - no previously-included directories found matching 'build' 22:42:12 INFO - no previously-included directories found matching 'dist' 22:42:12 INFO - no previously-included directories found matching '.git*' 22:42:12 INFO - Successfully installed jsonschema functools32 22:42:12 INFO - Cleaning up... 22:42:12 INFO - Return code: 0 22:42:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1851a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', '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 22:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:42:12 INFO - Using env: {'DISPLAY': ':0', 22:42:12 INFO - 'HOME': '/home/cltbld', 22:42:12 INFO - 'LANG': 'en_US.UTF-8', 22:42:12 INFO - 'LANGUAGE': 'en_US:en', 22:42:12 INFO - 'LOGNAME': 'cltbld', 22:42:12 INFO - 'MAIL': '/var/mail/cltbld', 22:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:12 INFO - 'MOZ_NO_REMOTE': '1', 22:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:12 INFO - 'NO_EM_RESTART': '1', 22:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:12 INFO - 'PWD': '/builds/slave/test', 22:42:12 INFO - 'SHELL': '/bin/bash', 22:42:12 INFO - 'SHLVL': '1', 22:42:12 INFO - 'TERM': 'linux', 22:42:12 INFO - 'TMOUT': '86400', 22:42:12 INFO - 'USER': 'cltbld', 22:42:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:12 INFO - '_': '/tools/buildbot/bin/python'} 22:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:42:12 INFO - Cleaning up... 22:42:12 INFO - Return code: 0 22:42:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1851a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', '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 22:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:42:12 INFO - Using env: {'DISPLAY': ':0', 22:42:12 INFO - 'HOME': '/home/cltbld', 22:42:12 INFO - 'LANG': 'en_US.UTF-8', 22:42:12 INFO - 'LANGUAGE': 'en_US:en', 22:42:12 INFO - 'LOGNAME': 'cltbld', 22:42:12 INFO - 'MAIL': '/var/mail/cltbld', 22:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:12 INFO - 'MOZ_NO_REMOTE': '1', 22:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:12 INFO - 'NO_EM_RESTART': '1', 22:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:12 INFO - 'PWD': '/builds/slave/test', 22:42:12 INFO - 'SHELL': '/bin/bash', 22:42:12 INFO - 'SHLVL': '1', 22:42:12 INFO - 'TERM': 'linux', 22:42:12 INFO - 'TMOUT': '86400', 22:42:12 INFO - 'USER': 'cltbld', 22:42:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:12 INFO - '_': '/tools/buildbot/bin/python'} 22:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:13 INFO - Downloading/unpacking blobuploader==1.2.4 22:42:13 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 22:42:13 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 22:42:13 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 22:42:13 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 22:42:13 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 22:42:13 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 22:42:15 INFO - Downloading blobuploader-1.2.4.tar.gz 22:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:42:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:42:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 INFO - Downloading docopt-0.6.1.tar.gz 22:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:42:15 INFO - Installing collected packages: blobuploader, requests, docopt 22:42:15 INFO - Running setup.py install for blobuploader 22:42:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:42:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:42:15 INFO - Running setup.py install for requests 22:42:16 INFO - Running setup.py install for docopt 22:42:16 INFO - Successfully installed blobuploader requests docopt 22:42:16 INFO - Cleaning up... 22:42:16 INFO - Return code: 0 22:42:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:16 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')]} 22:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:16 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')]} 22:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:16 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 0x17411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1851a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', '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 22:42:16 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 22:42:16 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 22:42:16 INFO - Using env: {'DISPLAY': ':0', 22:42:16 INFO - 'HOME': '/home/cltbld', 22:42:16 INFO - 'LANG': 'en_US.UTF-8', 22:42:16 INFO - 'LANGUAGE': 'en_US:en', 22:42:16 INFO - 'LOGNAME': 'cltbld', 22:42:16 INFO - 'MAIL': '/var/mail/cltbld', 22:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:16 INFO - 'MOZ_NO_REMOTE': '1', 22:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:16 INFO - 'NO_EM_RESTART': '1', 22:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:16 INFO - 'PWD': '/builds/slave/test', 22:42:16 INFO - 'SHELL': '/bin/bash', 22:42:16 INFO - 'SHLVL': '1', 22:42:16 INFO - 'TERM': 'linux', 22:42:16 INFO - 'TMOUT': '86400', 22:42:16 INFO - 'USER': 'cltbld', 22:42:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:16 INFO - '_': '/tools/buildbot/bin/python'} 22:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:42:16 INFO - Running setup.py (path:/tmp/pip-VkERV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:42:16 INFO - Running setup.py (path:/tmp/pip-OIPGZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:42:16 INFO - Running setup.py (path:/tmp/pip-togmIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:42:16 INFO - Running setup.py (path:/tmp/pip-e7hYbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:42:16 INFO - Running setup.py (path:/tmp/pip-8hDv1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:42:17 INFO - Running setup.py (path:/tmp/pip-8XCbf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:42:17 INFO - Running setup.py (path:/tmp/pip-JMCO6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:42:17 INFO - Running setup.py (path:/tmp/pip-dp_MlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:42:17 INFO - Running setup.py (path:/tmp/pip-lrc3GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:42:17 INFO - Running setup.py (path:/tmp/pip-cDMyQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:42:17 INFO - Running setup.py (path:/tmp/pip-RbPE_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:42:17 INFO - Running setup.py (path:/tmp/pip-vzgAgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:42:17 INFO - Running setup.py (path:/tmp/pip-IvNUPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:42:17 INFO - Running setup.py (path:/tmp/pip-9QhlcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:17 INFO - Running setup.py (path:/tmp/pip-sA2U3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:42:17 INFO - Running setup.py (path:/tmp/pip-x5_5Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:42:17 INFO - Running setup.py (path:/tmp/pip-nmM_ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:42:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:42:17 INFO - Running setup.py install for manifestparser 22:42:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Running setup.py install for mozcrash 22:42:18 INFO - Running setup.py install for mozdebug 22:42:18 INFO - Running setup.py install for mozdevice 22:42:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Running setup.py install for mozfile 22:42:18 INFO - Running setup.py install for mozhttpd 22:42:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Running setup.py install for mozinfo 22:42:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Running setup.py install for mozInstall 22:42:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Running setup.py install for mozleak 22:42:18 INFO - Running setup.py install for mozlog 22:42:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Running setup.py install for moznetwork 22:42:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Running setup.py install for mozprocess 22:42:19 INFO - Running setup.py install for mozprofile 22:42:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Running setup.py install for mozrunner 22:42:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Running setup.py install for mozscreenshot 22:42:19 INFO - Running setup.py install for moztest 22:42:19 INFO - Running setup.py install for mozversion 22:42:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:42:19 INFO - Cleaning up... 22:42:19 INFO - Return code: 0 22:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:19 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')]} 22:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:19 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')]} 22:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:19 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 0x17411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1851a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', '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 22:42:19 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 22:42:19 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 22:42:19 INFO - Using env: {'DISPLAY': ':0', 22:42:19 INFO - 'HOME': '/home/cltbld', 22:42:19 INFO - 'LANG': 'en_US.UTF-8', 22:42:19 INFO - 'LANGUAGE': 'en_US:en', 22:42:19 INFO - 'LOGNAME': 'cltbld', 22:42:19 INFO - 'MAIL': '/var/mail/cltbld', 22:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:19 INFO - 'MOZ_NO_REMOTE': '1', 22:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:19 INFO - 'NO_EM_RESTART': '1', 22:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:19 INFO - 'PWD': '/builds/slave/test', 22:42:19 INFO - 'SHELL': '/bin/bash', 22:42:19 INFO - 'SHLVL': '1', 22:42:19 INFO - 'TERM': 'linux', 22:42:19 INFO - 'TMOUT': '86400', 22:42:19 INFO - 'USER': 'cltbld', 22:42:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:19 INFO - '_': '/tools/buildbot/bin/python'} 22:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:42:19 INFO - Running setup.py (path:/tmp/pip-rBt1mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:42:20 INFO - Running setup.py (path:/tmp/pip-88BAUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:42:20 INFO - Running setup.py (path:/tmp/pip-a3jZP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:42:20 INFO - Running setup.py (path:/tmp/pip-7fx9F0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:42:20 INFO - Running setup.py (path:/tmp/pip-NDb7S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:42:20 INFO - Running setup.py (path:/tmp/pip-j4N0Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:42:20 INFO - Running setup.py (path:/tmp/pip-JZ8S4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:42:20 INFO - Running setup.py (path:/tmp/pip-SWZmwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:42:20 INFO - Running setup.py (path:/tmp/pip-WzaiEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:42:20 INFO - Running setup.py (path:/tmp/pip-hokMVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:42:20 INFO - Running setup.py (path:/tmp/pip-AfOgFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:42:20 INFO - Running setup.py (path:/tmp/pip-q9mkuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:42:20 INFO - Running setup.py (path:/tmp/pip-c303Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:42:20 INFO - Running setup.py (path:/tmp/pip-Thhvdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:20 INFO - Running setup.py (path:/tmp/pip-yyOUNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:21 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:42:21 INFO - Running setup.py (path:/tmp/pip-PQ29YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:42:21 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:42:21 INFO - Running setup.py (path:/tmp/pip-kctO73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:42:21 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)) 22:42:21 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)) 22:42:21 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)) 22:42:21 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)) 22:42:21 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)) 22:42:21 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)) 22:42:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:42:21 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 22:42:21 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 22:42:21 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 22:42:21 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 22:42:21 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 22:42:21 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 22:42:23 INFO - Downloading blessings-1.6.tar.gz 22:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:42:23 INFO - Installing collected packages: blessings 22:42:23 INFO - Running setup.py install for blessings 22:42:23 INFO - Successfully installed blessings 22:42:23 INFO - Cleaning up... 22:42:23 INFO - Return code: 0 22:42:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:23 INFO - Reading from file tmpfile_stdout 22:42:23 INFO - Current package versions: 22:42:23 INFO - argparse == 1.2.1 22:42:23 INFO - blessings == 1.6 22:42:23 INFO - blobuploader == 1.2.4 22:42:23 INFO - docopt == 0.6.1 22:42:23 INFO - functools32 == 3.2.3-2 22:42:23 INFO - jsonschema == 2.5.1 22:42:23 INFO - manifestparser == 1.1 22:42:23 INFO - mozInstall == 1.12 22:42:23 INFO - mozcrash == 1.0 22:42:23 INFO - mozdebug == 0.1 22:42:23 INFO - mozdevice == 0.49 22:42:23 INFO - mozfile == 1.2 22:42:23 INFO - mozhttpd == 0.7 22:42:23 INFO - mozinfo == 0.9 22:42:23 INFO - mozleak == 0.1 22:42:23 INFO - mozlog == 3.4 22:42:23 INFO - moznetwork == 0.27 22:42:23 INFO - mozprocess == 0.24 22:42:23 INFO - mozprofile == 0.28 22:42:23 INFO - mozrunner == 6.13 22:42:23 INFO - mozscreenshot == 0.1 22:42:23 INFO - mozsystemmonitor == 0.3 22:42:23 INFO - moztest == 0.8 22:42:23 INFO - mozversion == 1.4 22:42:23 INFO - psutil == 3.1.1 22:42:23 INFO - requests == 1.2.3 22:42:23 INFO - wsgiref == 0.1.2 22:42:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:23 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 0x17411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1851a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', '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 22:42:23 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 22:42:23 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 22:42:23 INFO - Using env: {'DISPLAY': ':0', 22:42:23 INFO - 'HOME': '/home/cltbld', 22:42:23 INFO - 'LANG': 'en_US.UTF-8', 22:42:23 INFO - 'LANGUAGE': 'en_US:en', 22:42:23 INFO - 'LOGNAME': 'cltbld', 22:42:23 INFO - 'MAIL': '/var/mail/cltbld', 22:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:23 INFO - 'MOZ_NO_REMOTE': '1', 22:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:23 INFO - 'NO_EM_RESTART': '1', 22:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:23 INFO - 'PWD': '/builds/slave/test', 22:42:23 INFO - 'SHELL': '/bin/bash', 22:42:23 INFO - 'SHLVL': '1', 22:42:23 INFO - 'TERM': 'linux', 22:42:23 INFO - 'TMOUT': '86400', 22:42:23 INFO - 'USER': 'cltbld', 22:42:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:23 INFO - '_': '/tools/buildbot/bin/python'} 22:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:23 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)) 22:42:23 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)) 22:42:23 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)) 22:42:23 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)) 22:42:23 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)) 22:42:23 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)) 22:42:23 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)) 22:42:23 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)) 22:42:23 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)) 22:42:23 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)) 22:42:23 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)) 22:42:23 INFO - Cleaning up... 22:42:23 INFO - Return code: 0 22:42:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:23 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 0x17411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1851a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', '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 22:42:23 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 22:42:23 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 22:42:23 INFO - Using env: {'DISPLAY': ':0', 22:42:23 INFO - 'HOME': '/home/cltbld', 22:42:23 INFO - 'LANG': 'en_US.UTF-8', 22:42:23 INFO - 'LANGUAGE': 'en_US:en', 22:42:23 INFO - 'LOGNAME': 'cltbld', 22:42:23 INFO - 'MAIL': '/var/mail/cltbld', 22:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:23 INFO - 'MOZ_NO_REMOTE': '1', 22:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:23 INFO - 'NO_EM_RESTART': '1', 22:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:23 INFO - 'PWD': '/builds/slave/test', 22:42:23 INFO - 'SHELL': '/bin/bash', 22:42:23 INFO - 'SHLVL': '1', 22:42:23 INFO - 'TERM': 'linux', 22:42:23 INFO - 'TMOUT': '86400', 22:42:23 INFO - 'USER': 'cltbld', 22:42:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:23 INFO - '_': '/tools/buildbot/bin/python'} 22:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:42:24 INFO - Cleaning up... 22:42:24 INFO - Return code: 0 22:42:24 INFO - Running post-action listener: _resource_record_post_action 22:42:24 INFO - Running post-action listener: _start_resource_monitoring 22:42:24 INFO - Starting resource monitoring. 22:42:24 INFO - [mozharness: 2017-01-31 06:42:24.160559Z] Finished create-virtualenv step (success) 22:42:24 INFO - [mozharness: 2017-01-31 06:42:24.161063Z] Running install step. 22:42:24 INFO - Running pre-action listener: _resource_record_pre_action 22:42:24 INFO - Running main action method: install 22:42:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:24 INFO - Reading from file tmpfile_stdout 22:42:24 INFO - Detecting whether we're running mozinstall >=1.0... 22:42:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:42:24 INFO - Reading from file tmpfile_stdout 22:42:24 INFO - Output received: 22:42:24 INFO - Usage: mozinstall [options] installer 22:42:24 INFO - Options: 22:42:24 INFO - -h, --help show this help message and exit 22:42:24 INFO - -d DEST, --destination=DEST 22:42:24 INFO - Directory to install application into. [default: 22:42:24 INFO - "/builds/slave/test"] 22:42:24 INFO - --app=APP Application being installed. [default: firefox] 22:42:24 INFO - mkdir: /builds/slave/test/build/application 22:42:24 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'] 22:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:42:40 INFO - Reading from file tmpfile_stdout 22:42:40 INFO - Output received: 22:42:40 INFO - /builds/slave/test/build/application/firefox/firefox 22:42:40 INFO - Running post-action listener: _resource_record_post_action 22:42:40 INFO - [mozharness: 2017-01-31 06:42:40.711722Z] Finished install step (success) 22:42:40 INFO - [mozharness: 2017-01-31 06:42:40.711997Z] Running run-tests step. 22:42:40 INFO - Running pre-action listener: _resource_record_pre_action 22:42:40 INFO - Running main action method: run_tests 22:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:42:40 INFO - Python 2.7.3 22:42:40 INFO - Return code: 0 22:42:40 INFO - grabbing minidump binary from tooltool 22:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:40 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 0x1b3c850>, '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 0x1ab16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:42:40 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 22:42:40 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 22:42:40 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 22:42:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:42:40 INFO - Return code: 0 22:42:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:42:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:42:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:42:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:42:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:42:40 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/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 22:42:40 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/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 22:42:40 INFO - Using env: {'DISPLAY': ':0', 22:42:40 INFO - 'HOME': '/home/cltbld', 22:42:40 INFO - 'LANG': 'en_US.UTF-8', 22:42:40 INFO - 'LANGUAGE': 'en_US:en', 22:42:40 INFO - 'LOGNAME': 'cltbld', 22:42:40 INFO - 'MAIL': '/var/mail/cltbld', 22:42:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:42:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:40 INFO - 'MOZ_NO_REMOTE': '1', 22:42:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:40 INFO - 'NO_EM_RESTART': '1', 22:42:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:40 INFO - 'PWD': '/builds/slave/test', 22:42:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:42:40 INFO - 'SHELL': '/bin/bash', 22:42:40 INFO - 'SHLVL': '1', 22:42:40 INFO - 'TERM': 'linux', 22:42:40 INFO - 'TMOUT': '86400', 22:42:40 INFO - 'USER': 'cltbld', 22:42:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483', 22:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:40 INFO - '_': '/tools/buildbot/bin/python'} 22:42:40 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/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 22:42:40 INFO - mozversion application_buildid: 20170131060754 22:42:40 INFO - mozversion application_changeset: 9c06e744b1befb3a2e2fdac7414ce18220774a1d 22:42:40 INFO - mozversion application_display_name: Nightly 22:42:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:42:40 INFO - mozversion application_name: Firefox 22:42:40 INFO - mozversion application_remotingname: firefox 22:42:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:42:41 INFO - mozversion application_vendor: Mozilla 22:42:41 INFO - mozversion application_version: 54.0a1 22:42:41 INFO - mozversion platform_buildid: 20170131060754 22:42:41 INFO - mozversion platform_changeset: 9c06e744b1befb3a2e2fdac7414ce18220774a1d 22:42:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:42:41 INFO - mozversion platform_version: 54.0a1 22:42:41 INFO - using testdate: 1485844960 22:42:41 INFO - actual date: 1485844960 22:42:41 INFO - starting webserver on 'localhost:49986' 22:42:41 INFO - SUITE-START | Running 2 tests 22:42:41 INFO - TEST-START | dromaeo_css 22:42:41 INFO - operating with platform_type : linux_ 22:42:41 INFO - Initialising browser for dromaeo_css test... 22:42:41 INFO - TEST-INFO | started process 23274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplFCsmF/profile http://localhost:49986/getInfo.html) 22:42:44 INFO - PROCESS | 23274 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 22:42:44 INFO - PROCESS | 23274 | __metrics Screen width/height:1600/1200 22:42:44 INFO - PROCESS | 23274 | colorDepth:24 22:42:44 INFO - PROCESS | 23274 | Browser inner width/height: 1024/697 22:42:44 INFO - PROCESS | 23274 | __metrics 22:42:45 INFO - PROCESS | 23274 | 1485844965460 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 22:42:45 INFO - PROCESS | 23274 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:42:45 INFO - PROCESS | 23274 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:42:46 INFO - PROCESS | 23274 | console.error: PushService: 22:42:46 INFO - PROCESS | 23274 | stateChangeProcessEnqueue: Error transitioning state 22:42:46 INFO - PROCESS | 23274 | UnknownError 22:42:46 INFO - TEST-INFO | 23274: exit 0 22:42:46 INFO - Browser initialized. 22:42:46 INFO - Running cycle 1/1 for dromaeo_css test... 22:42:46 INFO - TEST-INFO | started process 23355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplFCsmF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:58 INFO - PROCESS | 23355 | RSS: Main: 153804800 22:42:58 INFO - PROCESS | 23355 | 22:46:04 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:49986/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49986/tests/dromaeo/cssquery-ext.html) 22:46:05 INFO - PROCESS | 23355 | RSS: Main: 298426368 22:46:05 INFO - PROCESS | 23355 | 22:47:48 INFO - PROCESS | 23355 | ************************* 22:47:48 INFO - PROCESS | 23355 | A coding exception was thrown and uncaught in a Task. 22:47:48 INFO - PROCESS | 23355 | 22:47:48 ERROR - PROCESS | 23355 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:47:48 INFO - PROCESS | 23355 | Full stack: 22:47:48 INFO - PROCESS | 23355 | ************************* 22:49:08 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:49986/tests/dromaeo/cssquery-ext.html (next: http://localhost:49986/tests/dromaeo/cssquery-jquery.html) 22:49:09 INFO - PROCESS | 23355 | RSS: Main: 243372032 22:49:09 INFO - PROCESS | 23355 | 22:52:11 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:49986/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49986/tests/dromaeo/cssquery-mootools.html) 22:52:12 INFO - PROCESS | 23355 | RSS: Main: 186585088 22:52:12 INFO - PROCESS | 23355 | 22:55:14 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:49986/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49986/tests/dromaeo/cssquery-prototype.html) 22:55:15 INFO - PROCESS | 23355 | RSS: Main: 186290176 22:55:15 INFO - PROCESS | 23355 | 22:58:18 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:49986/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49986/tests/dromaeo/cssquery-yui.html) 22:58:18 INFO - PROCESS | 23355 | RSS: Main: 187183104 22:58:18 INFO - PROCESS | 23355 | 23:01:21 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:49986/tests/dromaeo/cssquery-yui.html (next: http://localhost:49986/tests/dromaeo/cssquery-dojo.html) 23:01:22 INFO - PROCESS | 23355 | RSS: Main: 280850432 23:01:22 INFO - PROCESS | 23355 | 23:01:22 INFO - PROCESS | 23355 | __start_tp_report 23:01:22 INFO - PROCESS | 23355 | _x_x_mozilla_page_load 23:01:22 INFO - PROCESS | 23355 | _x_x_mozilla_page_load_details 23:01:22 INFO - PROCESS | 23355 | |i|pagename|runs| 23:01:22 INFO - PROCESS | 23355 | |0;dojo.html;2550.336912402775;2568.1140006697706;2588.689357277127;2605.726398728132;2607.0614578751647;4654.581087702106;4667.929981050279;4695.624350051996;4727.834525791603;4739.668223224376;4689.742064186468;4715.174844402224;4758.904821903559;4783.497732738065;4812.879678008052;4288.69979101463;4342.261815491374;4375.015621485156;4416.73499590024;4435.046465010022;4133.627973482386;4421.447319085114;4423.823047078129;4473.351364052211;4518.322251662261;4264.9147017059795;4345.348197770328;4352.347147927804;4370.519242883281;4441.911161776762;4261.829526818923;4271.743695378287;4327.545607711208;4334.241507736134;4414.3157810539415;4327.415798867144;4341.761203133827;4343.131373725236;4344.044310251739;4387.034852332482;4728.763561821929;4765.904681906342;4770.666053376231;4772.6897751646375;4818.325434439182;4972.502749725035;4978.601711863079;4996.900061998776;4998.225275082368;5012.8997420051755;5042.067217564762;5048.192289233742;5048.671836330626;5054.7472626368535;5078.6698864574055;4724.598409135193;4729.07782982322;4729.290606409066;4769.1177132230305;4777.976110119496;5063.569596584258;5082.288479612857;5117.334746482933;5136.2295655651205;5200.7139607321205;5008.373953255843;5012.273220383024;5012.699238045729;5049.141645920203;5058.671186372874;4970.478099799469;4989.80040798364;5089.745512724423;5098.439171691111;5146.588272938231;5014.84955451337;5017.724025178577;5020.2720605511995;5021.071101846097;5030.698158110525;4882.658213924991;4974.925376119361;4996.525330093636;4996.925046124311;5072.036313100499;4197.790110494524;4243.108947121139;4248.277792775236;4259;4284.2930916398445;3696.2237930034457;3696.74122811406;3712.814359282025;3716.4611131386337;3773.8867833965023;4390.165868485042;4425.137098265807;4432.3351497275025;4435.046465010038;4464.241079016575;5014.498550144956;5089.51649593288;5105.183170692671;5107.846764597068;5158.74206289684;4338.978305108454;4372;4380.474343078851;4392.604665580113;4460.219461594208;4556.612687921497;4587.105514424722;4587.3807036050375;4593.770311484413;4630.884227894329;4800.543948324904;4809.110314591811;4810.182269014206;4814.301926220608;4861.805527778991;4927.753612319298;4954.281629163823;5089.694618322913;5098.617603679665;5132.897342053213;4820.060088282751;4820.373351464287;4821.059893320768;4855.587275081516;4860.1008813369635;5030.3963524377305;5064.696118232918;5068.391792984866;5070.670406423571;5074.974625126851;5017;5055.1153548128195;5057.974710126426;5059.089363914531;5187.066328060985;4966.056449274771;4966.279889415942;4970.776315065758;5002.949970500394;5015.523525265094;4801.303810947463;4913.06651736169;4951.653384263067;4956.702597844141;5008.57427118699;4765.904681906273;4818.783154757974;4826.348442960156;4826.7827947743135;4835.129676658235;4881.9511804881495;4882.072406242944;4943.975280123576;4986.750662466935;4998.625103117353;4830.758462076952;4836.153673107263;4839.395075615548;4873.537013983666;4897.730624815669 23:01:22 INFO - PROCESS | 23355 | |1;ext.html;546.7676237599021;562.1230879827468;566.0744682444202;570.2985328046502;572.2875020599352;28892.133236002926;29711.55432668509;39354;41506.58493415065;41978.58021419785;41989.79005104978;42604.14791704164;42675;42680.57319426805;42763.14473710524;7715.498492597977;7891.802704932394;7897.5656338901335;7898.881516777253;7899.447038707292;7506.849863002737;7697.576633285167;7699.961500192491;7754.806129846743;7900.091489478697;10235.130013948823;10488.842667359995;10505.947470262638;10863.891361086367;10866.402347870904;10416.687499374993;10500.579976800918;10502.369857808557;10512.1590272778;10517.263791534557;10279.331843430153;10378.377297362107;10378.792424151474;10380.429076400795;10383;37497.250054998745;37671.4349284761;37732.622673773185;37767.62232377668;37776.62223377786;3657.7622454540638;3755;3756.098536351283;3759.154190307186;3794.4498047783195;26974.32564185911;28288.43423131526;28451.857740711162;29630.703692963227;29671.25821854471;3341.599008119017;3420.2304481491715;3463.3246516929207;3483.5819701635714;3494.9650503494895;254228;256438;257970.99999999814;259116;259360;48660.513394866306;49030;49043;49064;49083;48833.511664883605;48856.75571622119;48863;48920.75539622279;48967.265491017664;12324.938375308066;12610.117291789487;12674.683132921751;12694.238345699288;12694.682632934251;10180.185585153169;10225.130863876506;10239.539220735085;10256.897431025594;10268.691939241835;14701.705965880623;15123.621909452351;16123.435679751152;16280.75578866318;16647.667046659;6430.614163150226;6768.661566921634;6813.488988325896;6855.348741869514;6958.860822783618;784.2784638132931;785.0579304834222;795.7374066558021;804.0552350987566;817.4808996287401;27675.584866227022;27932.58101128485;28476.85761571179;28699.56950645742;28934.710652893624;950.2065775077749;954.379653225409;975.5366201054443;978.0365492557562;1082.312731415541;14172.519809033378;14414.351354188877;15382.692346153015;15665.216739163225;15675;380493;382252;382918;383185;383585;40614.59385406167;41157.176856462705;46564.7671761639;47483.28775068377;47504.524954750705;1177.31127290536;1206.6078524479578;1207.5049229815734;1207.7524107557929;1211.9333436661068;25250.242492725247;26347.473050538498;26504.602430963936;26640.20079397621;26688.599671004562;39737.80131099326;40625.1874962505;40661.39007914943;40724;40782.79608601938;340087;341972;342675;342794;343036;24120.51758964776;24166.87916560406;24408.389790255387;24488.877555612107;24504.754952450246;33361.499577506846;33939.66060339365;34712.65287347094;36387.45418818773;38209.2358152841;27556;31378.52932205973;31427.84286078555;32073.518897217025;32966.67033329636;32513.512297315086;32595;32606.34787304288;33024.834875825465;33103.172420689676;32173.35653286968;33000.66999329976;33095.50356744699;33120.50319245261;33142.66857331396;26380.60429093527;27137.379426037416;29167.708322917348;29577.408451831274;29733.256668583457;22656.546869062855;22904.77095229093;23039.6544051836;23218.3034508965;23232.186873459348 23:01:22 INFO - PROCESS | 23355 | |2;jquery.html;357.6369984465766;376.1348897535669;386.661671037842;388.578392444198;410.98767036988903;13274.800877986838;17116.572085697848;17298.56753581161;17708.557286067855;19203.903980480114;16931.153442327864;17189.74215386767;17242.82757172428;17290.56773580661;17305;4899.779509922053;5179.585633149358;5211.661242019276;5214.087534681435;5215.504527069922;3735.9439608405896;3913.3934240192675;5090.720010399426;5178.974105129488;5839.270091238595;6021.939780602203;6151.384861513858;6177.196964394645;6177.567570270083;6182.783602573911;5962.403759624046;6112.419320164578;6144.907826382608;6153.323134455206;6179.165812615284;5439.129739241742;5442.9727851360885;5443.782248710047;5449.6730196187955;5450.5367043801325;13269;17192.484225473258;19885.801141988683;20591;20681.17275309001;2160.5786871560053;2228.6099932511906;2229.8996545155346;2250.1786847800436;2274.10172981673;9027.187553120186;9066.229370503515;9110.316726245492;9178.770530736718;9548.236141108695;1721.2512557037728;1740.7301868210448;1742.468547093136;1777.173614269371;1778.6175972166047;80651.5967420165;81133.18866811374;82131.07213567205;84470;87949;10355.844662330072;10439.217058720626;10585.100266477435;10636.255462117577;10711.410872402093;15063.397464101314;15080.472183473526;15090.094594324375;15110.471133510495;15119.54641360761;7233.168185658611;7356.595387253752;7487.326140647259;7525.3227209551405;7553.131389890233;6768.9661551691925;6842.178938527409;6865.347791959756;7022.754203602849;7051.1891132519395;4619.86140415788;4650.651201159859;4652.976735116303;4714.834980775657;4718.4337879454;1708.2056843567552;1711.152979275242;1724.7930248370026;1734.3149455965076;1771.6240885013995;754.3927138653327;796.474326944214;800.3477166109602;816.322452364536;819.1890028871375;16335.918320408322;17129.96696178155;17221.052842093555;17996.550086247687;18007.909960450113;792.3225642076058;803.6745118227127;804.9597520123971;826.277007618334;829.241244261506;9086.091390860993;9410.482423466776;9647.903520964841;9691.466969316614;9868.851967220497;511574;522717;532829;533488;533906;91283;93319;94161;94499.52750236342;96032.11502217168;909.777104609375;935.2004036548789;960.4333443268505;966.9323147379616;967.8693376394097;15735.527934161993;15837.920810395874;16531.66936661236;16544.50366489007;16752.246148923085;40670.186596268504;40907.795461022506;41729.58270417379;41783.373249400676;42125.4193393565;52383;52393.214101789265;57783;59265;60949.69525152346;7710.720804284919;8031.1567285434185;8126.674933002851;8209.589520524069;8291.58542072882;11779.293242405483;12042.651682922096;12320.199187052813;12327.876721232673;12890.484380625045;9391.060893910828;9539.952300238454;9890.357126787023;9937.801243975224;11578.189526733047;9124.908750912406;10464.476776161313;10671.679849604525;10962.671119866416;11065.723356916142;9945.651902183388;10001.199904007808;11177.217594768288;11293.209475336647;11495.367754773568;7895.802604934923;7909.762707118795;7972.720954766555;7984.441089123706;8066.435349525477;8005.119436861824;9842.360246583949;10194.388336699525;10240.283180177315;11028.558857645605 23:01:22 INFO - PROCESS | 23355 | |3;mootools.html;1278.9168704034237;1304.4716889659692;1308.6793735534795;1309.404221079409;1314.7896336586145;7080.716771329147;7503.212162722917;7504;7510.887336689947;7510.96244518778;6612.074309596648;6803.1836179658385;7072.186698529671;7340.26597340267;7383.150937642173;2166.599179151854;2198.2635817001324;2198.4174193838567;2203.966940495886;2204.614192516311;2114.069809283918;2173.3371321746863;2179.923702670407;2182.0508078985613;2190.759016508183;1865.6268746250737;1936.4384328544775;2088;2128.9893550532224;2149.1296025109855;2165.220520612578;2170.848040637156;2173.1959175105153;2173.271953895431;2177.5427160296435;2120.120150137691;2143.8284937204985;2146.152269853399;2150.3441450357636;2155.277981876073;7539.132999705049;7571.167171611173;7619.847603047908;7621.047369078865;7625.694972201105;4399.428074350346;4508.932366014513;4518.3222516622445;4525.2533332000185;4527.547245275446;2799.205644316266;2893.754030907375;2939.3974235281717;2980.165553644983;2988.2678743707716;1017.0592202212923;1031.752379428939;1039.7660526381578;1041.979160416795;1103.5034234594384;9791.951040244754;9887.209023278121;9918.25613079022;9920.255980801468;9938.602455901755;3930.567637559866;4175.791210439465;4234.364845273234;4294.141171765659;4328.5455027222315;8774.210321071134;8780.692675756318;8792.252658523968;8802.339824513187;8817.955910220408;4598.471175814824;4607.055553611569;4607.700499467591;4610.008848097675;4610.700304480198;3557.626449222846;3679.3377192105145;4024.2756303865585;4099.344104943195;4187.748735075906;3569.910752231215;3584.982075089608;3703.0742314421395;3703.5926048134684;3714.6998550507105;1182.6097387861985;1193.242291145129;1202.5550546297925;1204.6687161030786;1212.1817773003188;771.5910567399287;776.6427443375998;777.2577188784697;779.9571023593643;786.2726977545748;4661.696989695659;4737.526247375235;4741.739204343794;4836.709797412166;4923.704577725348;488.99511004890206;512.5950499105664;841.0152041182804;889.7864512517078;891.80826122384;3076.32320889404;3081.8978422723135;3107.735842453372;3154.4322022036254;3222.452183128874;8808.339374546935;8940.642374305085;9063.410878293022;9087.454752714726;9162.358634895627;9035.051319611477;9045.502497362708;9054.411463254868;9062.139096785795;9071.455712657262;6908.171019477594;7110.537815042006;7159.355657990805;7160.427165826722;7180.820479488055;4762.404699412574;4809.9038019240115;4813.446453657874;4846.733429661403;4863.562279394871;8084.9191508086515;8102.270795628422;8238.052623948322;8271.296939759946;8319.584020798815;8246.917530824854;8394.580270986304;8490.533020683923;8494.277986371228;8495.915040849759;5709.7145142741865;5909.202257695328;5995.700214989321;6095.634261944298;6154.107654390178;6914.8617027660175;7167.211606723361;7176.210616832249;7317.451191160791;7318.634068296457;6564.212294524496;6650.268470468148;6663.933360666525;6695.163104611924;6822.863542729018;6445.097686323825;6456.612603243821;6494.772682956074;6665.7333706653135;6699.296573859675;5659.773609055756;5680.346760122638;5684.2947115864245;5734.426557344399;5736.971315143398;4218.409422680766;4241.87274381769;4267.1892340455215;4269.210196113729;4331.047169622678;4227.894302642459;4233.618974292329;4245.066085461317;4283.721558098714;4300.548442413627 23:01:22 INFO - PROCESS | 23355 | |4;prototype.html;341.9504171895075;353.87083714444225;356.1061735045036;356.2714249360058;357.20521838908417;4686.976565117174;4754.500777418369;4769.904601907969;4771.830901429151;4825.71045737256;4736.43162820462;4748.6703722957545;4755.453122890868;4775.137696298438;4801.759912004394;3631.8365673544686;3752.1370084880496;3799.3161230978412;3817.331966905794;3823.7381664050936;3833.869008642443;3834.3481608126544;3849.4610754494392;3856.672182864446;3865.1640470776438;3831.7700937943673;3833.8466461341513;3840.3087444260022;3842.7502212356108;3848.7883166425836;3699.8890033298776;3704.407294832827;3787.772733635991;3830.3296923038356;3847.769133851964;3447.77589456687;3450.9309813803834;3457.6888080072663;3469;3485.42490489069;4608.585227329523;4621;4626.1441633297945;4628.722276663411;4652.092841895832;4235.195312890541;4300.102734507468;4341.196878577473;4349.891252718676;4351.108022855307;4897;4938.629602779806;4942.777575009133;4948.529889660476;4958.553730164303;3761.22894806564;3778.282126395976;3782.2624588205313;3798.4112462568346;3810.3615445358487;5193.324867767204;5196.3885099855615;5232.633715639907;5232.9738351308;5235.816746413895;3466.6706662866986;3644.726645501598;3657.8719744808805;3667.9816600916824;3672.265546890633;3711.31340701971;3722.4230244312175;3723.646253605903;3732.4401339798706;3744.5319335083113;4246.8301267949555;4253.404523366731;4257.5529569395385;4273.529911709709;4278.7860606969525;4748.198562847936;4945.505449455026;5010.924836127461;5039.899202015939;5048.72232027242;1251.8670603104206;1257.3147634539198;1261.7508666420179;1266.202292555684;1268.7525932443084;842.8482873082781;853.108501615813;871.847426700325;874.5889431966965;883.1521739130378;4206.453161089039;4284.293091639907;4315.546867578922;4403.207422663887;4403.8238470461465;5122.743862806845;5123;5155.690658560498;5160.612954028388;5168.379794424618;4359.956400436018;4381.38660587518;4394.890127746768;4399.5820397062225;4404.66964977628;2533.214703441939;2613.359726866892;2619.2142357292737;2636.1827833371717;2646.570851740077;4660.231061874752;4671.6919262606525;4683.437987441529;4683.555062269079;4685.49326110536;5085.32184379154;5086.364204474441;5103.5295998720485;5111.361079865017;5112.284280200774;4495;4660.184467718136;4660.836870709509;4671.5328467153695;4714.95285047152;4890.731009794496;4948.38145231846;4952.424739135701;4955.479674634112;4979.800807967786;4838.588719958843;4840.419149702058;4847.442544107332;4848.642380133569;4860.635452341018;4365.367021781887;4589.541045895384;4657.67396282257;4662.440507139165;4680.812767489262;3494.4932984716565;3507.403741363923;3512.3677738007405;3539.4603347543903;3551.5915669698315;4952.755944856125;4963.181075122564;5005.99880024004;5007.5993920487;5024;4660.487346391962;4782.282657601388;4812.590929771009;4826.3243145958895;4903.95096049035;4778.737169455713;4790.353302304145;4811.687240329367;4813.350197723263;4829.710217386968;4735.857924262277;4740.5733483986605;4746.477887432311;4772.518290488996;4786.234202527578;4594.21898277287;4842.201036828884;4863.270509423473;4942.258661200704;4986.202207646759;4877.487863774252;4892.535209155125;4896.9755151225445;4901.58336541398;4907.950920490892 23:01:22 INFO - PROCESS | 23355 | |5;yui.html;644.6744394080988;671.2381447057585;701.1936273285721;701.4458577723599;715.4920006795177;12511.624651260465;12883.033772467079;12889.613311600644;13016.544420945269;13042.1522601031;13018.47926082958;13116.934415327934;13127.277999710011;13137.080404371698;13172.209667419962;655.8983357579559;673.4679603113559;791.9960400197991;802.1296892871242;811.2293321344716;792.7106606088794;795.3756301303478;796.1759578835906;798.8522123407188;798.9041315042203;870.899846517649;872.2106493623281;872.3021582733819;872.8603423452249;873.0832625742976;692.055344454818;710.1123595505618;710.9324614161646;711.964401779914;863.3352318714586;612.8314713453835;623.7754408412968;628.346519619595;628.8710814283061;629.8016124920636;13418.798718019238;13582.728345433135;13648.249346285951;13707.327071221016;13711.245881476514;12895.742085158337;13100.410481528354;13158;13178.472861085545;13212.207267563881;11474.541018359256;11495.942520287344;11577.47901344433;11641;11792.35142067186;3152.8265945372996;3240.675932406764;3319.1038419626807;3381.7463690223085;3382.3404436134965;63762.681186594236;65304.346956530775;65487;66670;67211;10197.18422526196;10212.897871021343;10459.529321180566;10522.368657880552;10554.630587929385;18519.72220416695;18527.907360463112;18616.44150675455;18626.720599191023;18675.719864201776;6593.307702691244;6593.472522198213;6595.538312318187;6645.202575690948;6841.931580684229;3529.942987004632;3582.8925132246072;3603.3153700796765;3625.5830579483168;3637.0361854108683;2879.3665393613373;2926.5902773611288;2944.455275773989;2953.4979053560946;2957.4085182963063;497.60670123653625;500.8247113510315;506.6883866422124;507.7562769870483;510.5558164396924;595.675356930474;613.8005148326812;616.5776443136466;624.2633692243106;629.7827249598881;9030.819383612423;9144.3598948073;9589.472579008081;9640.42157470554;9776.706698799047;662.5262937000068;666.2504682232488;680.7923583307139;682.853186564891;691.3639451704444;4173.4157217989505;4437.090396468716;4449.310356894686;4456.977715111404;4516.412866327422;53661.46338536643;53674.7316263424;53758.73120634372;67251.99122013173;68799.65600172068;37216.813915930245;56419.43580564142;57715.711421442626;58390.12414813781;58448.12327815086;51195;51653.966920661376;51847;52386.73806630942;52900.73549632304;8254.54599997006;8422.452540584842;8438.620262088343;8463.619137138967;8597.355198360023;35753.82123089368;35834.8208258957;36087.81956090308;36779;37290.8135459321;45880.31179532243;47294;48923.266151007054;51672;51849;12469.251844889335;12568.49726010986;13055.673608159872;13096.476140954255;13131.474741010252;13112.601882748344;13460.461581536629;13529.793069060084;13617.591472255848;14104.36530356157;10811.189160812813;11166.218364714718;11357;12419.93790031044;12863.035272354799;12414.193077449936;12763.872361276268;13171.275579842817;13181.40683669218;13546.661333466742;11827.526898923947;12258.325792081521;12398.194117382702;12526.624201273977;12837;9938.801223975624;10139.898601013896;10179.49102544855;10223.948880255848;10337.0696637303;10479.68560943173;10624.52189651483;10666.946665266623;10777.912693831027;10934.234603577992 23:01:22 INFO - PROCESS | 23355 | __end_tp_report 23:01:22 INFO - PROCESS | 23355 | __start_cc_report 23:01:22 INFO - PROCESS | 23355 | _x_x_mozilla_cycle_collect,1538 23:01:22 INFO - PROCESS | 23355 | __end_cc_report 23:01:22 INFO - PROCESS | 23355 | __startTimestamp1485846082080__endTimestamp 23:01:22 INFO - PROCESS | 23355 | 23:01:22 INFO - PROCESS | 23355 | ------- Summary: start ------- 23:01:22 INFO - PROCESS | 23355 | Number of tests: 6 23:01:22 INFO - PROCESS | 23355 | 23:01:22 INFO - PROCESS | 23355 | [#0] dojo.html Cycles:165 Average:4679.48 Median:4820.06 stddev:496.67 (10.3%) stddev-sans-first:469.27 23:01:22 INFO - PROCESS | 23355 | Values: 2550.3 2568.1 2588.7 2605.7 2607.1 4654.6 4667.9 4695.6 4727.8 4739.7 4689.7 4715.2 4758.9 4783.5 4812.9 4288.7 4342.3 4375.0 4416.7 4435.0 4133.6 4421.4 4423.8 4473.4 4518.3 4264.9 4345.3 4352.3 4370.5 4441.9 4261.8 4271.7 4327.5 4334.2 4414.3 4327.4 4341.8 4343.1 4344.0 4387.0 4728.8 4765.9 4770.7 4772.7 4818.3 4972.5 4978.6 4996.9 4998.2 5012.9 5042.1 5048.2 5048.7 5054.7 5078.7 4724.6 4729.1 4729.3 4769.1 4778.0 5063.6 5082.3 5117.3 5136.2 5200.7 5008.4 5012.3 5012.7 5049.1 5058.7 4970.5 4989.8 5089.7 5098.4 5146.6 5014.8 5017.7 5020.3 5021.1 5030.7 4882.7 4974.9 4996.5 4996.9 5072.0 4197.8 4243.1 4248.3 4259.0 4284.3 3696.2 3696.7 3712.8 3716.5 3773.9 4390.2 4425.1 4432.3 4435.0 4464.2 5014.5 5089.5 5105.2 5107.8 5158.7 4339.0 4372.0 4380.5 4392.6 4460.2 4556.6 4587.1 4587.4 4593.8 4630.9 4800.5 4809.1 4810.2 4814.3 4861.8 4927.8 4954.3 5089.7 5098.6 5132.9 4820.1 4820.4 4821.1 4855.6 4860.1 5030.4 5064.7 5068.4 5070.7 5075.0 5017.0 5055.1 5058.0 5059.1 5187.1 4966.1 4966.3 4970.8 5002.9 5015.5 4801.3 4913.1 4951.7 4956.7 5008.6 4765.9 4818.8 4826.3 4826.8 4835.1 4882.0 4882.1 4944.0 4986.8 4998.6 4830.8 4836.2 4839.4 4873.5 4897.7 23:01:22 INFO - PROCESS | 23355 | 23:01:22 INFO - PROCESS | 23355 | [#1] ext.html Cycles:180 Average:46967.32 Median:33111.84 stddev:87340.99 (263.8%) stddev-sans-first:87516.46 23:01:22 INFO - PROCESS | 23355 | Values: 546.8 562.1 566.1 570.3 572.3 28892.1 29711.6 39354.0 41506.6 41978.6 41989.8 42604.1 42675.0 42680.6 42763.1 7715.5 7891.8 7897.6 7898.9 7899.4 7506.8 7697.6 7700.0 7754.8 7900.1 10235.1 10488.8 10505.9 10863.9 10866.4 10416.7 10500.6 10502.4 10512.2 10517.3 10279.3 10378.4 10378.8 10380.4 10383.0 37497.3 37671.4 37732.6 37767.6 37776.6 3657.8 3755.0 3756.1 3759.2 3794.4 26974.3 28288.4 28451.9 29630.7 29671.3 3341.6 3420.2 3463.3 3483.6 3495.0 254228.0 256438.0 257971.0 259116.0 259360.0 48660.5 49030.0 49043.0 49064.0 49083.0 48833.5 48856.8 48863.0 48920.8 48967.3 12324.9 12610.1 12674.7 12694.2 12694.7 10180.2 10225.1 10239.5 10256.9 10268.7 14701.7 15123.6 16123.4 16280.8 16647.7 6430.6 6768.7 6813.5 6855.3 6958.9 784.3 785.1 795.7 804.1 817.5 27675.6 27932.6 28476.9 28699.6 28934.7 950.2 954.4 975.5 978.0 1082.3 14172.5 14414.4 15382.7 15665.2 15675.0 380493.0 382252.0 382918.0 383185.0 383585.0 40614.6 41157.2 46564.8 47483.3 47504.5 1177.3 1206.6 1207.5 1207.8 1211.9 25250.2 26347.5 26504.6 26640.2 26688.6 39737.8 40625.2 40661.4 40724.0 40782.8 340087.0 341972.0 342675.0 342794.0 343036.0 24120.5 24166.9 24408.4 24488.9 24504.8 33361.5 33939.7 34712.7 36387.5 38209.2 27556.0 31378.5 31427.8 32073.5 32966.7 32513.5 32595.0 32606.3 33024.8 33103.2 32173.4 33000.7 33095.5 33120.5 33142.7 26380.6 27137.4 29167.7 29577.4 29733.3 22656.5 22904.8 23039.7 23218.3 23232.2 23:01:22 INFO - PROCESS | 23355 | 23:01:22 INFO - PROCESS | 23355 | [#2] jquery.html Cycles:180 Average:29366.29 Median:5214.80 stddev:86899.97 (1666.4%) stddev-sans-first:87116.45 23:01:22 INFO - PROCESS | 23355 | Values: 357.6 376.1 386.7 388.6 411.0 13274.8 17116.6 17298.6 17708.6 19203.9 16931.2 17189.7 17242.8 17290.6 17305.0 4899.8 5179.6 5211.7 5214.1 5215.5 3735.9 3913.4 5090.7 5179.0 5839.3 6021.9 6151.4 6177.2 6177.6 6182.8 5962.4 6112.4 6144.9 6153.3 6179.2 5439.1 5443.0 5443.8 5449.7 5450.5 13269.0 17192.5 19885.8 20591.0 20681.2 2160.6 2228.6 2229.9 2250.2 2274.1 9027.2 9066.2 9110.3 9178.8 9548.2 1721.3 1740.7 1742.5 1777.2 1778.6 80651.6 81133.2 82131.1 84470.0 87949.0 10355.8 10439.2 10585.1 10636.3 10711.4 15063.4 15080.5 15090.1 15110.5 15119.5 7233.2 7356.6 7487.3 7525.3 7553.1 6769.0 6842.2 6865.3 7022.8 7051.2 4619.9 4650.7 4653.0 4714.8 4718.4 1708.2 1711.2 1724.8 1734.3 1771.6 754.4 796.5 800.3 816.3 819.2 16335.9 17130.0 17221.1 17996.6 18007.9 792.3 803.7 805.0 826.3 829.2 9086.1 9410.5 9647.9 9691.5 9868.9 511574.0 522717.0 532829.0 533488.0 533906.0 91283.0 93319.0 94161.0 94499.5 96032.1 909.8 935.2 960.4 966.9 967.9 15735.5 15837.9 16531.7 16544.5 16752.2 40670.2 40907.8 41729.6 41783.4 42125.4 52383.0 52393.2 57783.0 59265.0 60949.7 7710.7 8031.2 8126.7 8209.6 8291.6 11779.3 12042.7 12320.2 12327.9 12890.5 9391.1 9540.0 9890.4 9937.8 11578.2 9124.9 10464.5 10671.7 10962.7 11065.7 9945.7 10001.2 11177.2 11293.2 11495.4 7895.8 7909.8 7972.7 7984.4 8066.4 8005.1 9842.4 10194.4 10240.3 11028.6 23:01:22 INFO - PROCESS | 23355 | 23:01:22 INFO - PROCESS | 23355 | [#3] mootools.html Cycles:180 Average:4872.78 Median:4825.08 stddev:2689.71 (55.7%) stddev-sans-first:2683.70 23:01:22 INFO - PROCESS | 23355 | Values: 1278.9 1304.5 1308.7 1309.4 1314.8 7080.7 7503.2 7504.0 7510.9 7511.0 6612.1 6803.2 7072.2 7340.3 7383.2 2166.6 2198.3 2198.4 2204.0 2204.6 2114.1 2173.3 2179.9 2182.1 2190.8 1865.6 1936.4 2088.0 2129.0 2149.1 2165.2 2170.8 2173.2 2173.3 2177.5 2120.1 2143.8 2146.2 2150.3 2155.3 7539.1 7571.2 7619.8 7621.0 7625.7 4399.4 4508.9 4518.3 4525.3 4527.5 2799.2 2893.8 2939.4 2980.2 2988.3 1017.1 1031.8 1039.8 1042.0 1103.5 9792.0 9887.2 9918.3 9920.3 9938.6 3930.6 4175.8 4234.4 4294.1 4328.5 8774.2 8780.7 8792.3 8802.3 8818.0 4598.5 4607.1 4607.7 4610.0 4610.7 3557.6 3679.3 4024.3 4099.3 4187.7 3569.9 3585.0 3703.1 3703.6 3714.7 1182.6 1193.2 1202.6 1204.7 1212.2 771.6 776.6 777.3 780.0 786.3 4661.7 4737.5 4741.7 4836.7 4923.7 489.0 512.6 841.0 889.8 891.8 3076.3 3081.9 3107.7 3154.4 3222.5 8808.3 8940.6 9063.4 9087.5 9162.4 9035.1 9045.5 9054.4 9062.1 9071.5 6908.2 7110.5 7159.4 7160.4 7180.8 4762.4 4809.9 4813.4 4846.7 4863.6 8084.9 8102.3 8238.1 8271.3 8319.6 8246.9 8394.6 8490.5 8494.3 8495.9 5709.7 5909.2 5995.7 6095.6 6154.1 6914.9 7167.2 7176.2 7317.5 7318.6 6564.2 6650.3 6663.9 6695.2 6822.9 6445.1 6456.6 6494.8 6665.7 6699.3 5659.8 5680.3 5684.3 5734.4 5737.0 4218.4 4241.9 4267.2 4269.2 4331.0 4227.9 4233.6 4245.1 4283.7 4300.5 23:01:22 INFO - PROCESS | 23355 | 23:01:22 INFO - PROCESS | 23355 | [#4] prototype.html Cycles:180 Average:4111.81 Median:4660.21 stddev:1159.18 (24.9%) stddev-sans-first:1127.37 23:01:22 INFO - PROCESS | 23355 | Values: 342.0 353.9 356.1 356.3 357.2 4687.0 4754.5 4769.9 4771.8 4825.7 4736.4 4748.7 4755.5 4775.1 4801.8 3631.8 3752.1 3799.3 3817.3 3823.7 3833.9 3834.3 3849.5 3856.7 3865.2 3831.8 3833.8 3840.3 3842.8 3848.8 3699.9 3704.4 3787.8 3830.3 3847.8 3447.8 3450.9 3457.7 3469.0 3485.4 4608.6 4621.0 4626.1 4628.7 4652.1 4235.2 4300.1 4341.2 4349.9 4351.1 4897.0 4938.6 4942.8 4948.5 4958.6 3761.2 3778.3 3782.3 3798.4 3810.4 5193.3 5196.4 5232.6 5233.0 5235.8 3466.7 3644.7 3657.9 3668.0 3672.3 3711.3 3722.4 3723.6 3732.4 3744.5 4246.8 4253.4 4257.6 4273.5 4278.8 4748.2 4945.5 5010.9 5039.9 5048.7 1251.9 1257.3 1261.8 1266.2 1268.8 842.8 853.1 871.8 874.6 883.2 4206.5 4284.3 4315.5 4403.2 4403.8 5122.7 5123.0 5155.7 5160.6 5168.4 4360.0 4381.4 4394.9 4399.6 4404.7 2533.2 2613.4 2619.2 2636.2 2646.6 4660.2 4671.7 4683.4 4683.6 4685.5 5085.3 5086.4 5103.5 5111.4 5112.3 4495.0 4660.2 4660.8 4671.5 4715.0 4890.7 4948.4 4952.4 4955.5 4979.8 4838.6 4840.4 4847.4 4848.6 4860.6 4365.4 4589.5 4657.7 4662.4 4680.8 3494.5 3507.4 3512.4 3539.5 3551.6 4952.8 4963.2 5006.0 5007.6 5024.0 4660.5 4782.3 4812.6 4826.3 4904.0 4778.7 4790.4 4811.7 4813.4 4829.7 4735.9 4740.6 4746.5 4772.5 4786.2 4594.2 4842.2 4863.3 4942.3 4986.2 4877.5 4892.5 4897.0 4901.6 4908.0 23:01:22 INFO - PROCESS | 23355 | 23:01:22 INFO - PROCESS | 23355 | [#5] yui.html Cycles:180 Average:14970.13 Median:4305.25 stddev:18148.32 (421.5%) stddev-sans-first:18167.35 23:01:22 INFO - PROCESS | 23355 | Values: 644.7 671.2 701.2 701.4 715.5 12511.6 12883.0 12889.6 13016.5 13042.2 13018.5 13116.9 13127.3 13137.1 13172.2 655.9 673.5 792.0 802.1 811.2 792.7 795.4 796.2 798.9 798.9 870.9 872.2 872.3 872.9 873.1 692.1 710.1 710.9 712.0 863.3 612.8 623.8 628.3 628.9 629.8 13418.8 13582.7 13648.2 13707.3 13711.2 12895.7 13100.4 13158.0 13178.5 13212.2 11474.5 11495.9 11577.5 11641.0 11792.4 3152.8 3240.7 3319.1 3381.7 3382.3 63762.7 65304.3 65487.0 66670.0 67211.0 10197.2 10212.9 10459.5 10522.4 10554.6 18519.7 18527.9 18616.4 18626.7 18675.7 6593.3 6593.5 6595.5 6645.2 6841.9 3529.9 3582.9 3603.3 3625.6 3637.0 2879.4 2926.6 2944.5 2953.5 2957.4 497.6 500.8 506.7 507.8 510.6 595.7 613.8 616.6 624.3 629.8 9030.8 9144.4 9589.5 9640.4 9776.7 662.5 666.3 680.8 682.9 691.4 4173.4 4437.1 4449.3 4457.0 4516.4 53661.5 53674.7 53758.7 67252.0 68799.7 37216.8 56419.4 57715.7 58390.1 58448.1 51195.0 51654.0 51847.0 52386.7 52900.7 8254.5 8422.5 8438.6 8463.6 8597.4 35753.8 35834.8 36087.8 36779.0 37290.8 45880.3 47294.0 48923.3 51672.0 51849.0 12469.3 12568.5 13055.7 13096.5 13131.5 13112.6 13460.5 13529.8 13617.6 14104.4 10811.2 11166.2 11357.0 12419.9 12863.0 12414.2 12763.9 13171.3 13181.4 13546.7 11827.5 12258.3 12398.2 12526.6 12837.0 9938.8 10139.9 10179.5 10223.9 10337.1 10479.7 10624.5 10666.9 10777.9 10934.2 23:01:22 INFO - PROCESS | 23355 | -------- Summary: end -------- 23:01:22 INFO - PROCESS | 23355 | 23:01:22 INFO - TEST-INFO | 23355: exit 0 23:01:22 INFO - TEST-OK | dromaeo_css | took 1121925ms 23:01:22 INFO - TEST-START | kraken 23:01:22 INFO - operating with platform_type : linux_ 23:01:22 INFO - Initialising browser for kraken test... 23:01:22 INFO - TEST-INFO | started process 23657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpThThTz/profile http://localhost:49986/getInfo.html) 23:01:26 INFO - PROCESS | 23657 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 23:01:27 INFO - PROCESS | 23657 | __metrics Screen width/height:1600/1200 23:01:27 INFO - PROCESS | 23657 | colorDepth:24 23:01:27 INFO - PROCESS | 23657 | Browser inner width/height: 1024/697 23:01:27 INFO - PROCESS | 23657 | __metrics 23:01:27 INFO - PROCESS | 23657 | 1485846087482 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 23:01:27 INFO - PROCESS | 23657 | 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" 23:01:27 INFO - PROCESS | 23657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:01:28 INFO - PROCESS | 23657 | console.error: PushService: 23:01:28 INFO - PROCESS | 23657 | stateChangeProcessEnqueue: Error transitioning state 23:01:28 INFO - PROCESS | 23657 | UnknownError 23:01:28 INFO - TEST-INFO | 23657: exit 0 23:01:28 INFO - Browser initialized. 23:01:28 INFO - Running cycle 1/1 for kraken test... 23:01:28 INFO - TEST-INFO | started process 23737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpThThTz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:40 INFO - PROCESS | 23737 | RSS: Main: 153858048 23:01:40 INFO - PROCESS | 23737 | 23:01:43 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49986/tests/kraken/driver.html?testName=audio-beat-detection) 23:01:44 INFO - PROCESS | 23737 | RSS: Main: 208814080 23:01:44 INFO - PROCESS | 23737 | 23:01:47 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49986/tests/kraken/driver.html?testName=audio-dft) 23:01:47 INFO - PROCESS | 23737 | RSS: Main: 187645952 23:01:47 INFO - PROCESS | 23737 | 23:01:50 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49986/tests/kraken/driver.html?testName=audio-fft) 23:01:51 INFO - PROCESS | 23737 | RSS: Main: 270073856 23:01:51 INFO - PROCESS | 23737 | 23:01:53 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49986/tests/kraken/driver.html?testName=audio-oscillator) 23:01:54 INFO - PROCESS | 23737 | RSS: Main: 181538816 23:01:54 INFO - PROCESS | 23737 | 23:01:56 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49986/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:01:57 INFO - PROCESS | 23737 | RSS: Main: 184967168 23:01:57 INFO - PROCESS | 23737 | 23:02:00 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49986/tests/kraken/driver.html?testName=imaging-darkroom) 23:02:00 INFO - PROCESS | 23737 | RSS: Main: 224456704 23:02:00 INFO - PROCESS | 23737 | 23:02:04 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49986/tests/kraken/driver.html?testName=imaging-desaturate) 23:02:04 INFO - PROCESS | 23737 | RSS: Main: 218333184 23:02:04 INFO - PROCESS | 23737 | 23:02:07 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49986/tests/kraken/driver.html?testName=json-parse-financial) 23:02:08 INFO - PROCESS | 23737 | RSS: Main: 220209152 23:02:08 INFO - PROCESS | 23737 | 23:02:10 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49986/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:02:10 INFO - PROCESS | 23737 | RSS: Main: 183521280 23:02:10 INFO - PROCESS | 23737 | 23:02:12 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49986/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:02:13 INFO - PROCESS | 23737 | RSS: Main: 190205952 23:02:13 INFO - PROCESS | 23737 | 23:02:15 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49986/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:02:16 INFO - PROCESS | 23737 | RSS: Main: 199000064 23:02:16 INFO - PROCESS | 23737 | 23:02:18 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:02:19 INFO - PROCESS | 23737 | RSS: Main: 209059840 23:02:19 INFO - PROCESS | 23737 | 23:02:22 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:02:23 INFO - PROCESS | 23737 | RSS: Main: 205451264 23:02:23 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | Cycle 1(1): loaded http://localhost:49986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49986/tests/kraken/driver.html?testName=ai-astar) 23:02:25 INFO - PROCESS | 23737 | RSS: Main: 257409024 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | __start_tp_report 23:02:25 INFO - PROCESS | 23737 | _x_x_mozilla_page_load 23:02:25 INFO - PROCESS | 23737 | _x_x_mozilla_page_load_details 23:02:25 INFO - PROCESS | 23737 | |i|pagename|runs| 23:02:25 INFO - PROCESS | 23737 | |0;ai-astar;109;117;117;120;117;118;116;117;116;118 23:02:25 INFO - PROCESS | 23737 | |1;audio-beat-detection;147;124;123;160;126;129;126;123;155;130 23:02:25 INFO - PROCESS | 23737 | |2;audio-dft;162;159;161;161;162;161;162;161;163;161 23:02:25 INFO - PROCESS | 23737 | |3;audio-fft;75;76;76;109;76;77;77;79;93;76 23:02:25 INFO - PROCESS | 23737 | |4;audio-oscillator;84;84;112;84;84;85;108;83;84;108 23:02:25 INFO - PROCESS | 23737 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;116;117;117 23:02:25 INFO - PROCESS | 23737 | |6;imaging-darkroom;149;148;148;149;150;149;148;149;149;150 23:02:25 INFO - PROCESS | 23737 | |7;imaging-desaturate;96;95;95;95;95;94;95;96;95;95 23:02:25 INFO - PROCESS | 23737 | |8;json-parse-financial;65;65;74;69;75;65;66;67;65;66 23:02:25 INFO - PROCESS | 23737 | |9;json-stringify-tinderbox;66;66;66;66;67;67;66;67;67;67 23:02:25 INFO - PROCESS | 23737 | |10;stanford-crypto-aes;85;85;84;87;85;85;85;85;87;83 23:02:25 INFO - PROCESS | 23737 | |11;stanford-crypto-ccm;143;133;135;133;137;133;132;131;176;146 23:02:25 INFO - PROCESS | 23737 | |12;stanford-crypto-pbkdf2;178;177;180;177;179;193;177;178;178;175 23:02:25 INFO - PROCESS | 23737 | |13;stanford-crypto-sha256-iterative;69;70;66;66;69;67;71;67;67;66 23:02:25 INFO - PROCESS | 23737 | __end_tp_report 23:02:25 INFO - PROCESS | 23737 | __start_cc_report 23:02:25 INFO - PROCESS | 23737 | _x_x_mozilla_cycle_collect,1862 23:02:25 INFO - PROCESS | 23737 | __end_cc_report 23:02:25 INFO - PROCESS | 23737 | __startTimestamp1485846145320__endTimestamp 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | ------- Summary: start ------- 23:02:25 INFO - PROCESS | 23737 | Number of tests: 14 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.00 stddev:2.88 (2.5%) stddev-sans-first:1.22 23:02:25 INFO - PROCESS | 23737 | Values: 109.0 117.0 117.0 120.0 117.0 118.0 116.0 117.0 116.0 118.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:129.50 stddev:14.13 (10.9%) stddev-sans-first:14.22 23:02:25 INFO - PROCESS | 23737 | Values: 147.0 124.0 123.0 160.0 126.0 129.0 126.0 123.0 155.0 130.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 23:02:25 INFO - PROCESS | 23737 | Values: 162.0 159.0 161.0 161.0 162.0 161.0 162.0 161.0 163.0 161.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.50 stddev:11.05 (14.4%) stddev-sans-first:11.47 23:02:25 INFO - PROCESS | 23737 | Values: 75.0 76.0 76.0 109.0 76.0 77.0 77.0 79.0 93.0 76.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:84.00 stddev:12.29 (14.6%) stddev-sans-first:12.73 23:02:25 INFO - PROCESS | 23737 | Values: 84.0 84.0 112.0 84.0 84.0 85.0 108.0 83.0 84.0 108.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:02:25 INFO - PROCESS | 23737 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 116.0 117.0 117.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 23:02:25 INFO - PROCESS | 23737 | Values: 149.0 148.0 148.0 149.0 150.0 149.0 148.0 149.0 149.0 150.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 23:02:25 INFO - PROCESS | 23737 | Values: 96.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:66.50 stddev:3.80 (5.7%) stddev-sans-first:3.91 23:02:25 INFO - PROCESS | 23737 | Values: 65.0 65.0 74.0 69.0 75.0 65.0 66.0 67.0 65.0 66.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 23:02:25 INFO - PROCESS | 23737 | Values: 66.0 66.0 66.0 66.0 67.0 67.0 66.0 67.0 67.0 67.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:1.20 (1.4%) stddev-sans-first:1.27 23:02:25 INFO - PROCESS | 23737 | Values: 85.0 85.0 84.0 87.0 85.0 85.0 85.0 85.0 87.0 83.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:136.00 stddev:13.61 (10.0%) stddev-sans-first:14.39 23:02:25 INFO - PROCESS | 23737 | Values: 143.0 133.0 135.0 133.0 137.0 133.0 132.0 131.0 176.0 146.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:178.00 stddev:5.03 (2.8%) stddev-sans-first:5.32 23:02:25 INFO - PROCESS | 23737 | Values: 178.0 177.0 180.0 177.0 179.0 193.0 177.0 178.0 178.0 175.0 23:02:25 INFO - PROCESS | 23737 | 23:02:25 INFO - PROCESS | 23737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.81 (2.7%) stddev-sans-first:1.87 23:02:25 INFO - PROCESS | 23737 | Values: 69.0 70.0 66.0 66.0 69.0 67.0 71.0 67.0 67.0 66.0 23:02:25 INFO - PROCESS | 23737 | -------- Summary: end -------- 23:02:25 INFO - PROCESS | 23737 | 23:02:26 INFO - TEST-INFO | 23737: exit 0 23:02:26 INFO - TEST-OK | kraken | took 63536ms 23:02:26 INFO - SUITE-END | took 1185s 23:02:26 INFO - Completed test suite (00:19:45) 23:02:26 INFO - javascript benchmark 23:02:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6348.565830728494, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2550.336912402775, 2568.1140006697706, 2588.689357277127, 2605.726398728132, 2607.0614578751647, 4654.581087702106, 4667.929981050279, 4695.624350051996, 4727.834525791603, 4739.668223224376, 4689.742064186468, 4715.174844402224, 4758.904821903559, 4783.497732738065, 4812.879678008052, 4288.69979101463, 4342.261815491374, 4375.015621485156, 4416.73499590024, 4435.046465010022, 4133.627973482386, 4421.447319085114, 4423.823047078129, 4473.351364052211, 4518.322251662261, 4264.9147017059795, 4345.348197770328, 4352.347147927804, 4370.519242883281, 4441.911161776762, 4261.829526818923, 4271.743695378287, 4327.545607711208, 4334.241507736134, 4414.3157810539415, 4327.415798867144, 4341.761203133827, 4343.131373725236, 4344.044310251739, 4387.034852332482, 4728.763561821929, 4765.904681906342, 4770.666053376231, 4772.6897751646375, 4818.325434439182, 4972.502749725035, 4978.601711863079, 4996.900061998776, 4998.225275082368, 5012.8997420051755, 5042.067217564762, 5048.192289233742, 5048.671836330626, 5054.7472626368535, 5078.6698864574055, 4724.598409135193, 4729.07782982322, 4729.290606409066, 4769.1177132230305, 4777.976110119496, 5063.569596584258, 5082.288479612857, 5117.334746482933, 5136.2295655651205, 5200.7139607321205, 5008.373953255843, 5012.273220383024, 5012.699238045729, 5049.141645920203, 5058.671186372874, 4970.478099799469, 4989.80040798364, 5089.745512724423, 5098.439171691111, 5146.588272938231, 5014.84955451337, 5017.724025178577, 5020.2720605511995, 5021.071101846097, 5030.698158110525, 4882.658213924991, 4974.925376119361, 4996.525330093636, 4996.925046124311, 5072.036313100499, 4197.790110494524, 4243.108947121139, 4248.277792775236, 4259.0, 4284.2930916398445, 3696.2237930034457, 3696.74122811406, 3712.814359282025, 3716.4611131386337, 3773.8867833965023, 4390.165868485042, 4425.137098265807, 4432.3351497275025, 4435.046465010038, 4464.241079016575, 5014.498550144956, 5089.51649593288, 5105.183170692671, 5107.846764597068, 5158.74206289684, 4338.978305108454, 4372.0, 4380.474343078851, 4392.604665580113, 4460.219461594208, 4556.612687921497, 4587.105514424722, 4587.3807036050375, 4593.770311484413, 4630.884227894329, 4800.543948324904, 4809.110314591811, 4810.182269014206, 4814.301926220608, 4861.805527778991, 4927.753612319298, 4954.281629163823, 5089.694618322913, 5098.617603679665, 5132.897342053213, 4820.060088282751, 4820.373351464287, 4821.059893320768, 4855.587275081516, 4860.1008813369635, 5030.3963524377305, 5064.696118232918, 5068.391792984866, 5070.670406423571, 5074.974625126851, 5017.0, 5055.1153548128195, 5057.974710126426, 5059.089363914531, 5187.066328060985, 4966.056449274771, 4966.279889415942, 4970.776315065758, 5002.949970500394, 5015.523525265094, 4801.303810947463, 4913.06651736169, 4951.653384263067, 4956.702597844141, 5008.57427118699, 4765.904681906273, 4818.783154757974, 4826.348442960156, 4826.7827947743135, 4835.129676658235, 4881.9511804881495, 4882.072406242944, 4943.975280123576, 4986.750662466935, 4998.625103117353, 4830.758462076952, 4836.153673107263, 4839.395075615548, 4873.537013983666, 4897.730624815669], "value": 4646.797563431472, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.7676237599021, 562.1230879827468, 566.0744682444202, 570.2985328046502, 572.2875020599352, 28892.133236002926, 29711.55432668509, 39354.0, 41506.58493415065, 41978.58021419785, 41989.79005104978, 42604.14791704164, 42675.0, 42680.57319426805, 42763.14473710524, 7715.498492597977, 7891.802704932394, 7897.5656338901335, 7898.881516777253, 7899.447038707292, 7506.849863002737, 7697.576633285167, 7699.961500192491, 7754.806129846743, 7900.091489478697, 10235.130013948823, 10488.842667359995, 10505.947470262638, 10863.891361086367, 10866.402347870904, 10416.687499374993, 10500.579976800918, 10502.369857808557, 10512.1590272778, 10517.263791534557, 10279.331843430153, 10378.377297362107, 10378.792424151474, 10380.429076400795, 10383.0, 37497.250054998745, 37671.4349284761, 37732.622673773185, 37767.62232377668, 37776.62223377786, 3657.7622454540638, 3755.0, 3756.098536351283, 3759.154190307186, 3794.4498047783195, 26974.32564185911, 28288.43423131526, 28451.857740711162, 29630.703692963227, 29671.25821854471, 3341.599008119017, 3420.2304481491715, 3463.3246516929207, 3483.5819701635714, 3494.9650503494895, 254228.0, 256438.0, 257970.99999999814, 259116.0, 259360.0, 48660.513394866306, 49030.0, 49043.0, 49064.0, 49083.0, 48833.511664883605, 48856.75571622119, 48863.0, 48920.75539622279, 48967.265491017664, 12324.938375308066, 12610.117291789487, 12674.683132921751, 12694.238345699288, 12694.682632934251, 10180.185585153169, 10225.130863876506, 10239.539220735085, 10256.897431025594, 10268.691939241835, 14701.705965880623, 15123.621909452351, 16123.435679751152, 16280.75578866318, 16647.667046659, 6430.614163150226, 6768.661566921634, 6813.488988325896, 6855.348741869514, 6958.860822783618, 784.2784638132931, 785.0579304834222, 795.7374066558021, 804.0552350987566, 817.4808996287401, 27675.584866227022, 27932.58101128485, 28476.85761571179, 28699.56950645742, 28934.710652893624, 950.2065775077749, 954.379653225409, 975.5366201054443, 978.0365492557562, 1082.312731415541, 14172.519809033378, 14414.351354188877, 15382.692346153015, 15665.216739163225, 15675.0, 380493.0, 382252.0, 382918.0, 383185.0, 383585.0, 40614.59385406167, 41157.176856462705, 46564.7671761639, 47483.28775068377, 47504.524954750705, 1177.31127290536, 1206.6078524479578, 1207.5049229815734, 1207.7524107557929, 1211.9333436661068, 25250.242492725247, 26347.473050538498, 26504.602430963936, 26640.20079397621, 26688.599671004562, 39737.80131099326, 40625.1874962505, 40661.39007914943, 40724.0, 40782.79608601938, 340087.0, 341972.0, 342675.0, 342794.0, 343036.0, 24120.51758964776, 24166.87916560406, 24408.389790255387, 24488.877555612107, 24504.754952450246, 33361.499577506846, 33939.66060339365, 34712.65287347094, 36387.45418818773, 38209.2358152841, 27556.0, 31378.52932205973, 31427.84286078555, 32073.518897217025, 32966.67033329636, 32513.512297315086, 32595.0, 32606.34787304288, 33024.834875825465, 33103.172420689676, 32173.35653286968, 33000.66999329976, 33095.50356744699, 33120.50319245261, 33142.66857331396, 26380.60429093527, 27137.379426037416, 29167.708322917348, 29577.408451831274, 29733.256668583457, 22656.546869062855, 22904.77095229093, 23039.6544051836, 23218.3034508965, 23232.186873459348], "value": 17258.46034595473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.6369984465766, 376.1348897535669, 386.661671037842, 388.578392444198, 410.98767036988903, 13274.800877986838, 17116.572085697848, 17298.56753581161, 17708.557286067855, 19203.903980480114, 16931.153442327864, 17189.74215386767, 17242.82757172428, 17290.56773580661, 17305.0, 4899.779509922053, 5179.585633149358, 5211.661242019276, 5214.087534681435, 5215.504527069922, 3735.9439608405896, 3913.3934240192675, 5090.720010399426, 5178.974105129488, 5839.270091238595, 6021.939780602203, 6151.384861513858, 6177.196964394645, 6177.567570270083, 6182.783602573911, 5962.403759624046, 6112.419320164578, 6144.907826382608, 6153.323134455206, 6179.165812615284, 5439.129739241742, 5442.9727851360885, 5443.782248710047, 5449.6730196187955, 5450.5367043801325, 13269.0, 17192.484225473258, 19885.801141988683, 20591.0, 20681.17275309001, 2160.5786871560053, 2228.6099932511906, 2229.8996545155346, 2250.1786847800436, 2274.10172981673, 9027.187553120186, 9066.229370503515, 9110.316726245492, 9178.770530736718, 9548.236141108695, 1721.2512557037728, 1740.7301868210448, 1742.468547093136, 1777.173614269371, 1778.6175972166047, 80651.5967420165, 81133.18866811374, 82131.07213567205, 84470.0, 87949.0, 10355.844662330072, 10439.217058720626, 10585.100266477435, 10636.255462117577, 10711.410872402093, 15063.397464101314, 15080.472183473526, 15090.094594324375, 15110.471133510495, 15119.54641360761, 7233.168185658611, 7356.595387253752, 7487.326140647259, 7525.3227209551405, 7553.131389890233, 6768.9661551691925, 6842.178938527409, 6865.347791959756, 7022.754203602849, 7051.1891132519395, 4619.86140415788, 4650.651201159859, 4652.976735116303, 4714.834980775657, 4718.4337879454, 1708.2056843567552, 1711.152979275242, 1724.7930248370026, 1734.3149455965076, 1771.6240885013995, 754.3927138653327, 796.474326944214, 800.3477166109602, 816.322452364536, 819.1890028871375, 16335.918320408322, 17129.96696178155, 17221.052842093555, 17996.550086247687, 18007.909960450113, 792.3225642076058, 803.6745118227127, 804.9597520123971, 826.277007618334, 829.241244261506, 9086.091390860993, 9410.482423466776, 9647.903520964841, 9691.466969316614, 9868.851967220497, 511574.0, 522717.0, 532829.0, 533488.0, 533906.0, 91283.0, 93319.0, 94161.0, 94499.52750236342, 96032.11502217168, 909.777104609375, 935.2004036548789, 960.4333443268505, 966.9323147379616, 967.8693376394097, 15735.527934161993, 15837.920810395874, 16531.66936661236, 16544.50366489007, 16752.246148923085, 40670.186596268504, 40907.795461022506, 41729.58270417379, 41783.373249400676, 42125.4193393565, 52383.0, 52393.214101789265, 57783.0, 59265.0, 60949.69525152346, 7710.720804284919, 8031.1567285434185, 8126.674933002851, 8209.589520524069, 8291.58542072882, 11779.293242405483, 12042.651682922096, 12320.199187052813, 12327.876721232673, 12890.484380625045, 9391.060893910828, 9539.952300238454, 9890.357126787023, 9937.801243975224, 11578.189526733047, 9124.908750912406, 10464.476776161313, 10671.679849604525, 10962.671119866416, 11065.723356916142, 9945.651902183388, 10001.199904007808, 11177.217594768288, 11293.209475336647, 11495.367754773568, 7895.802604934923, 7909.762707118795, 7972.720954766555, 7984.441089123706, 8066.435349525477, 8005.119436861824, 9842.360246583949, 10194.388336699525, 10240.283180177315, 11028.558857645605], "value": 8541.828002261333, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.9168704034237, 1304.4716889659692, 1308.6793735534795, 1309.404221079409, 1314.7896336586145, 7080.716771329147, 7503.212162722917, 7504.0, 7510.887336689947, 7510.96244518778, 6612.074309596648, 6803.1836179658385, 7072.186698529671, 7340.26597340267, 7383.150937642173, 2166.599179151854, 2198.2635817001324, 2198.4174193838567, 2203.966940495886, 2204.614192516311, 2114.069809283918, 2173.3371321746863, 2179.923702670407, 2182.0508078985613, 2190.759016508183, 1865.6268746250737, 1936.4384328544775, 2088.0, 2128.9893550532224, 2149.1296025109855, 2165.220520612578, 2170.848040637156, 2173.1959175105153, 2173.271953895431, 2177.5427160296435, 2120.120150137691, 2143.8284937204985, 2146.152269853399, 2150.3441450357636, 2155.277981876073, 7539.132999705049, 7571.167171611173, 7619.847603047908, 7621.047369078865, 7625.694972201105, 4399.428074350346, 4508.932366014513, 4518.3222516622445, 4525.2533332000185, 4527.547245275446, 2799.205644316266, 2893.754030907375, 2939.3974235281717, 2980.165553644983, 2988.2678743707716, 1017.0592202212923, 1031.752379428939, 1039.7660526381578, 1041.979160416795, 1103.5034234594384, 9791.951040244754, 9887.209023278121, 9918.25613079022, 9920.255980801468, 9938.602455901755, 3930.567637559866, 4175.791210439465, 4234.364845273234, 4294.141171765659, 4328.5455027222315, 8774.210321071134, 8780.692675756318, 8792.252658523968, 8802.339824513187, 8817.955910220408, 4598.471175814824, 4607.055553611569, 4607.700499467591, 4610.008848097675, 4610.700304480198, 3557.626449222846, 3679.3377192105145, 4024.2756303865585, 4099.344104943195, 4187.748735075906, 3569.910752231215, 3584.982075089608, 3703.0742314421395, 3703.5926048134684, 3714.6998550507105, 1182.6097387861985, 1193.242291145129, 1202.5550546297925, 1204.6687161030786, 1212.1817773003188, 771.5910567399287, 776.6427443375998, 777.2577188784697, 779.9571023593643, 786.2726977545748, 4661.696989695659, 4737.526247375235, 4741.739204343794, 4836.709797412166, 4923.704577725348, 488.99511004890206, 512.5950499105664, 841.0152041182804, 889.7864512517078, 891.80826122384, 3076.32320889404, 3081.8978422723135, 3107.735842453372, 3154.4322022036254, 3222.452183128874, 8808.339374546935, 8940.642374305085, 9063.410878293022, 9087.454752714726, 9162.358634895627, 9035.051319611477, 9045.502497362708, 9054.411463254868, 9062.139096785795, 9071.455712657262, 6908.171019477594, 7110.537815042006, 7159.355657990805, 7160.427165826722, 7180.820479488055, 4762.404699412574, 4809.9038019240115, 4813.446453657874, 4846.733429661403, 4863.562279394871, 8084.9191508086515, 8102.270795628422, 8238.052623948322, 8271.296939759946, 8319.584020798815, 8246.917530824854, 8394.580270986304, 8490.533020683923, 8494.277986371228, 8495.915040849759, 5709.7145142741865, 5909.202257695328, 5995.700214989321, 6095.634261944298, 6154.107654390178, 6914.8617027660175, 7167.211606723361, 7176.210616832249, 7317.451191160791, 7318.634068296457, 6564.212294524496, 6650.268470468148, 6663.933360666525, 6695.163104611924, 6822.863542729018, 6445.097686323825, 6456.612603243821, 6494.772682956074, 6665.7333706653135, 6699.296573859675, 5659.773609055756, 5680.346760122638, 5684.2947115864245, 5734.426557344399, 5736.971315143398, 4218.409422680766, 4241.87274381769, 4267.1892340455215, 4269.210196113729, 4331.047169622678, 4227.894302642459, 4233.618974292329, 4245.066085461317, 4283.721558098714, 4300.548442413627], "value": 3947.171192675812, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.9504171895075, 353.87083714444225, 356.1061735045036, 356.2714249360058, 357.20521838908417, 4686.976565117174, 4754.500777418369, 4769.904601907969, 4771.830901429151, 4825.71045737256, 4736.43162820462, 4748.6703722957545, 4755.453122890868, 4775.137696298438, 4801.759912004394, 3631.8365673544686, 3752.1370084880496, 3799.3161230978412, 3817.331966905794, 3823.7381664050936, 3833.869008642443, 3834.3481608126544, 3849.4610754494392, 3856.672182864446, 3865.1640470776438, 3831.7700937943673, 3833.8466461341513, 3840.3087444260022, 3842.7502212356108, 3848.7883166425836, 3699.8890033298776, 3704.407294832827, 3787.772733635991, 3830.3296923038356, 3847.769133851964, 3447.77589456687, 3450.9309813803834, 3457.6888080072663, 3469.0, 3485.42490489069, 4608.585227329523, 4621.0, 4626.1441633297945, 4628.722276663411, 4652.092841895832, 4235.195312890541, 4300.102734507468, 4341.196878577473, 4349.891252718676, 4351.108022855307, 4897.0, 4938.629602779806, 4942.777575009133, 4948.529889660476, 4958.553730164303, 3761.22894806564, 3778.282126395976, 3782.2624588205313, 3798.4112462568346, 3810.3615445358487, 5193.324867767204, 5196.3885099855615, 5232.633715639907, 5232.9738351308, 5235.816746413895, 3466.6706662866986, 3644.726645501598, 3657.8719744808805, 3667.9816600916824, 3672.265546890633, 3711.31340701971, 3722.4230244312175, 3723.646253605903, 3732.4401339798706, 3744.5319335083113, 4246.8301267949555, 4253.404523366731, 4257.5529569395385, 4273.529911709709, 4278.7860606969525, 4748.198562847936, 4945.505449455026, 5010.924836127461, 5039.899202015939, 5048.72232027242, 1251.8670603104206, 1257.3147634539198, 1261.7508666420179, 1266.202292555684, 1268.7525932443084, 842.8482873082781, 853.108501615813, 871.847426700325, 874.5889431966965, 883.1521739130378, 4206.453161089039, 4284.293091639907, 4315.546867578922, 4403.207422663887, 4403.8238470461465, 5122.743862806845, 5123.0, 5155.690658560498, 5160.612954028388, 5168.379794424618, 4359.956400436018, 4381.38660587518, 4394.890127746768, 4399.5820397062225, 4404.66964977628, 2533.214703441939, 2613.359726866892, 2619.2142357292737, 2636.1827833371717, 2646.570851740077, 4660.231061874752, 4671.6919262606525, 4683.437987441529, 4683.555062269079, 4685.49326110536, 5085.32184379154, 5086.364204474441, 5103.5295998720485, 5111.361079865017, 5112.284280200774, 4495.0, 4660.184467718136, 4660.836870709509, 4671.5328467153695, 4714.95285047152, 4890.731009794496, 4948.38145231846, 4952.424739135701, 4955.479674634112, 4979.800807967786, 4838.588719958843, 4840.419149702058, 4847.442544107332, 4848.642380133569, 4860.635452341018, 4365.367021781887, 4589.541045895384, 4657.67396282257, 4662.440507139165, 4680.812767489262, 3494.4932984716565, 3507.403741363923, 3512.3677738007405, 3539.4603347543903, 3551.5915669698315, 4952.755944856125, 4963.181075122564, 5005.99880024004, 5007.5993920487, 5024.0, 4660.487346391962, 4782.282657601388, 4812.590929771009, 4826.3243145958895, 4903.95096049035, 4778.737169455713, 4790.353302304145, 4811.687240329367, 4813.350197723263, 4829.710217386968, 4735.857924262277, 4740.5733483986605, 4746.477887432311, 4772.518290488996, 4786.234202527578, 4594.21898277287, 4842.201036828884, 4863.270509423473, 4942.258661200704, 4986.202207646759, 4877.487863774252, 4892.535209155125, 4896.9755151225445, 4901.58336541398, 4907.950920490892], "value": 3758.5023018589063, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.6744394080988, 671.2381447057585, 701.1936273285721, 701.4458577723599, 715.4920006795177, 12511.624651260465, 12883.033772467079, 12889.613311600644, 13016.544420945269, 13042.1522601031, 13018.47926082958, 13116.934415327934, 13127.277999710011, 13137.080404371698, 13172.209667419962, 655.8983357579559, 673.4679603113559, 791.9960400197991, 802.1296892871242, 811.2293321344716, 792.7106606088794, 795.3756301303478, 796.1759578835906, 798.8522123407188, 798.9041315042203, 870.899846517649, 872.2106493623281, 872.3021582733819, 872.8603423452249, 873.0832625742976, 692.055344454818, 710.1123595505618, 710.9324614161646, 711.964401779914, 863.3352318714586, 612.8314713453835, 623.7754408412968, 628.346519619595, 628.8710814283061, 629.8016124920636, 13418.798718019238, 13582.728345433135, 13648.249346285951, 13707.327071221016, 13711.245881476514, 12895.742085158337, 13100.410481528354, 13158.0, 13178.472861085545, 13212.207267563881, 11474.541018359256, 11495.942520287344, 11577.47901344433, 11641.0, 11792.35142067186, 3152.8265945372996, 3240.675932406764, 3319.1038419626807, 3381.7463690223085, 3382.3404436134965, 63762.681186594236, 65304.346956530775, 65487.0, 66670.0, 67211.0, 10197.18422526196, 10212.897871021343, 10459.529321180566, 10522.368657880552, 10554.630587929385, 18519.72220416695, 18527.907360463112, 18616.44150675455, 18626.720599191023, 18675.719864201776, 6593.307702691244, 6593.472522198213, 6595.538312318187, 6645.202575690948, 6841.931580684229, 3529.942987004632, 3582.8925132246072, 3603.3153700796765, 3625.5830579483168, 3637.0361854108683, 2879.3665393613373, 2926.5902773611288, 2944.455275773989, 2953.4979053560946, 2957.4085182963063, 497.60670123653625, 500.8247113510315, 506.6883866422124, 507.7562769870483, 510.5558164396924, 595.675356930474, 613.8005148326812, 616.5776443136466, 624.2633692243106, 629.7827249598881, 9030.819383612423, 9144.3598948073, 9589.472579008081, 9640.42157470554, 9776.706698799047, 662.5262937000068, 666.2504682232488, 680.7923583307139, 682.853186564891, 691.3639451704444, 4173.4157217989505, 4437.090396468716, 4449.310356894686, 4456.977715111404, 4516.412866327422, 53661.46338536643, 53674.7316263424, 53758.73120634372, 67251.99122013173, 68799.65600172068, 37216.813915930245, 56419.43580564142, 57715.711421442626, 58390.12414813781, 58448.12327815086, 51195.0, 51653.966920661376, 51847.0, 52386.73806630942, 52900.73549632304, 8254.54599997006, 8422.452540584842, 8438.620262088343, 8463.619137138967, 8597.355198360023, 35753.82123089368, 35834.8208258957, 36087.81956090308, 36779.0, 37290.8135459321, 45880.31179532243, 47294.0, 48923.266151007054, 51672.0, 51849.0, 12469.251844889335, 12568.49726010986, 13055.673608159872, 13096.476140954255, 13131.474741010252, 13112.601882748344, 13460.461581536629, 13529.793069060084, 13617.591472255848, 14104.36530356157, 10811.189160812813, 11166.218364714718, 11357.0, 12419.93790031044, 12863.035272354799, 12414.193077449936, 12763.872361276268, 13171.275579842817, 13181.40683669218, 13546.661333466742, 11827.526898923947, 12258.325792081521, 12398.194117382702, 12526.624201273977, 12837.0, 9938.801223975624, 10139.898601013896, 10179.49102544855, 10223.948880255848, 10337.0696637303, 10479.68560943173, 10624.52189651483, 10666.946665266623, 10777.912693831027, 10934.234603577992], "value": 6441.608954208964, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 117.0, 120.0, 117.0, 118.0, 116.0, 117.0, 116.0, 118.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 123.0, 160.0, 126.0, 129.0, 126.0, 123.0, 155.0, 130.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 163.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 109.0, 76.0, 77.0, 77.0, 79.0, 93.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 84.0, 84.0, 85.0, 108.0, 83.0, 84.0, 108.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 116.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 149.0, 150.0, 149.0, 148.0, 149.0, 149.0, 150.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 74.0, 69.0, 75.0, 65.0, 66.0, 67.0, 65.0, 66.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 87.0, 85.0, 85.0, 85.0, 85.0, 87.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 135.0, 133.0, 137.0, 133.0, 132.0, 131.0, 176.0, 146.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 180.0, 177.0, 179.0, 193.0, 177.0, 178.0, 178.0, 175.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 66.0, 66.0, 69.0, 67.0, 71.0, 67.0, 67.0, 66.0], "value": 67.8, "unit": "score"}]}]} 23:02:26 INFO - Return code: 0 23:02:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:02:26 ERROR - # TBPL SUCCESS # 23:02:26 INFO - Running post-action listener: _resource_record_post_action 23:02:26 INFO - [mozharness: 2017-01-31 07:02:26.604945Z] Finished run-tests step (success) 23:02:26 INFO - Running post-run listener: _resource_record_post_run 23:02:26 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 392687616; Read time: 24; Write time: 262584 23:02:26 INFO - TinderboxPrint: CPU usage
13.1% 23:02:26 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 23:02:26 INFO - TinderboxPrint: I/O write bytes / time
392,687,616 / 262,584 23:02:26 INFO - TinderboxPrint: CPU idle
8,336.0 (86.9%) 23:02:26 INFO - TinderboxPrint: CPU user
1,213.5 (12.6%) 23:02:26 INFO - TinderboxPrint: Swap in / out
0 / 0 23:02:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107614208; Read time: 0; Write time: 81196 23:02:26 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285069312; Read time: 8; Write time: 181388 23:02:27 INFO - Running post-run listener: _upload_blobber_files 23:02:27 INFO - Blob upload gear active. 23:02:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:02:27 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 23:02:27 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'] 23:02:27 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 23:02:27 INFO - (blobuploader) - INFO - Open directory for files ... 23:02:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:02:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:02:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:32 INFO - (blobuploader) - INFO - Done attempting. 23:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:33 INFO - (blobuploader) - INFO - Done attempting. 23:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:34 INFO - (blobuploader) - INFO - Done attempting. 23:02:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:02:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:02:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:35 INFO - (blobuploader) - INFO - Done attempting. 23:02:35 INFO - (blobuploader) - INFO - Iteration through files over. 23:02:35 INFO - Return code: 0 23:02:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:02:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:02:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ac21c650244ed6055bccf16e25c289b50ded891c7da7f3c0f6b870ad06e8d4e891f0abfa07d405aa71cb6271ec10818b2e03e8fa98e1ca8d4a8a8a412c0debc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ec059e811794ed1b5a5c1c89c5a9c688930b67aeb12b41d77a587cb571818b9e38cb0b51f80a92e906caa4dc948356510b2546adb21c0e5db9dc092c2ce2c3c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0d9565097bee3160c632bb377727ec39c36d59e26a17be8eb5bd7ccb300c6f71d6530222b2019cbad62e3f33dafb7a764c021dfeacbbd07f27082533727b29a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81e281b4594ad49d0a121f813b7101b6a625914d83335e46a721aaf3026e60840f47d29a8a710f15d9af23017a4fde848a809652dda268ea45c18b1b80f0c998"} 23:02:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:02:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:02:35 INFO - Contents: 23:02:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ac21c650244ed6055bccf16e25c289b50ded891c7da7f3c0f6b870ad06e8d4e891f0abfa07d405aa71cb6271ec10818b2e03e8fa98e1ca8d4a8a8a412c0debc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ec059e811794ed1b5a5c1c89c5a9c688930b67aeb12b41d77a587cb571818b9e38cb0b51f80a92e906caa4dc948356510b2546adb21c0e5db9dc092c2ce2c3c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0d9565097bee3160c632bb377727ec39c36d59e26a17be8eb5bd7ccb300c6f71d6530222b2019cbad62e3f33dafb7a764c021dfeacbbd07f27082533727b29a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81e281b4594ad49d0a121f813b7101b6a625914d83335e46a721aaf3026e60840f47d29a8a710f15d9af23017a4fde848a809652dda268ea45c18b1b80f0c998"} 23:02:35 INFO - Running post-run listener: copy_logs_to_upload_dir 23:02:35 INFO - Copying logs to upload dir... 23:02:35 INFO - mkdir: /builds/slave/test/build/upload/logs 23:02:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.299057 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-01-30 23:02:35.595675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 23:02:35.599420) ========= 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=20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ac21c650244ed6055bccf16e25c289b50ded891c7da7f3c0f6b870ad06e8d4e891f0abfa07d405aa71cb6271ec10818b2e03e8fa98e1ca8d4a8a8a412c0debc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ec059e811794ed1b5a5c1c89c5a9c688930b67aeb12b41d77a587cb571818b9e38cb0b51f80a92e906caa4dc948356510b2546adb21c0e5db9dc092c2ce2c3c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0d9565097bee3160c632bb377727ec39c36d59e26a17be8eb5bd7ccb300c6f71d6530222b2019cbad62e3f33dafb7a764c021dfeacbbd07f27082533727b29a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81e281b4594ad49d0a121f813b7101b6a625914d83335e46a721aaf3026e60840f47d29a8a710f15d9af23017a4fde848a809652dda268ea45c18b1b80f0c998"} build_url:https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/RgKIY3DMSXeFHtu3mjvffw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ac21c650244ed6055bccf16e25c289b50ded891c7da7f3c0f6b870ad06e8d4e891f0abfa07d405aa71cb6271ec10818b2e03e8fa98e1ca8d4a8a8a412c0debc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ec059e811794ed1b5a5c1c89c5a9c688930b67aeb12b41d77a587cb571818b9e38cb0b51f80a92e906caa4dc948356510b2546adb21c0e5db9dc092c2ce2c3c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0d9565097bee3160c632bb377727ec39c36d59e26a17be8eb5bd7ccb300c6f71d6530222b2019cbad62e3f33dafb7a764c021dfeacbbd07f27082533727b29a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81e281b4594ad49d0a121f813b7101b6a625914d83335e46a721aaf3026e60840f47d29a8a710f15d9af23017a4fde848a809652dda268ea45c18b1b80f0c998"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 23:02:35.625629) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 23:02:35.626141) ========= 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=20e666a3d4cfbb71505a330e000001b4-1485844904.602163-939847483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 23:02:35.707446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 23:02:35.707891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 23:02:35.708578) ========= ========= Total master_lag: 0.18 =========