builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1485718323.43 results: success (0) revision: 71224049c0b52ab190564d3ea0eab089a159a4cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:03.425590) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:03.426051) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:03.426351) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:03.450760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:03.451066) ========= 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=eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-29 11:32:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-01-29 11:32:04 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134538 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:03.603340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:03.603675) ========= 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=eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020098 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:03.669317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:03.669703) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 71224049c0b52ab190564d3ea0eab089a159a4cf --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 71224049c0b52ab190564d3ea0eab089a159a4cf --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=eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-29 11:32:04,875 truncating revision to first 12 chars 2017-01-29 11:32:04,875 Setting DEBUG logging. 2017-01-29 11:32:04,875 attempt 1/10 2017-01-29 11:32:04,875 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/71224049c0b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-29 11:32:05,215 unpacking tar archive at: mozilla-central-71224049c0b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659558 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:04.342577) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:04.343028) ========= script_repo_revision: 71224049c0b52ab190564d3ea0eab089a159a4cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:04.343460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:04.343758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-29 11:32:04.352482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-29 11:32:04.352778) ========= /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=eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:32:05 INFO - MultiFileLogger online at 20170129 11:32:05 in /builds/slave/test 11:32:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:32:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:32:05 INFO - {'append_to_log': False, 11:32:05 INFO - 'base_work_dir': '/builds/slave/test', 11:32:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:32:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:32:05 INFO - 'branch': 'Firefox-Non-PGO', 11:32:05 INFO - 'buildbot_json_path': 'buildprops.json', 11:32:05 INFO - 'config_files': ('talos/linux_config.py',), 11:32:05 INFO - 'default_actions': ('clobber', 11:32:05 INFO - 'read-buildbot-config', 11:32:05 INFO - 'download-and-extract', 11:32:05 INFO - 'populate-webroot', 11:32:05 INFO - 'create-virtualenv', 11:32:05 INFO - 'install', 11:32:05 INFO - 'run-tests'), 11:32:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:32:05 INFO - 'download_minidump_stackwalk': True, 11:32:05 INFO - 'download_symbols': 'ondemand', 11:32:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:32:05 INFO - 'tooltool.py': '/tools/tooltool.py', 11:32:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:32:05 INFO - '/tools/misc-python/virtualenv.py')}, 11:32:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:32:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:32:05 INFO - 'installer_path': 'installer.exe', 11:32:05 INFO - 'log_level': 'info', 11:32:05 INFO - 'log_name': 'talos', 11:32:05 INFO - 'log_to_console': True, 11:32:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:32:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:32:05 INFO - 'opt_config_files': (), 11:32:05 INFO - 'pip_index': False, 11:32:05 INFO - 'sps_profile': False, 11:32:05 INFO - 'sps_profile_interval': 0, 11:32:05 INFO - 'suite': 'dromaeojs', 11:32:05 INFO - 'system_bits': '32', 11:32:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:32:05 INFO - 'title': 'talos-linux64-ix-010', 11:32:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:32:05 INFO - 'use_talos_json': True, 11:32:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:32:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:32:05 INFO - 'work_dir': 'build'} 11:32:05 INFO - [mozharness: 2017-01-29 19:32:05.662858Z] Running clobber step. 11:32:05 INFO - Running pre-action listener: _resource_record_pre_action 11:32:05 INFO - Running main action method: clobber 11:32:05 INFO - rmtree: /builds/slave/test/build 11:32:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:32:06 INFO - Running post-action listener: _resource_record_post_action 11:32:06 INFO - [mozharness: 2017-01-29 19:32:06.124531Z] Finished clobber step (success) 11:32:06 INFO - [mozharness: 2017-01-29 19:32:06.124632Z] Running read-buildbot-config step. 11:32:06 INFO - Running pre-action listener: _resource_record_pre_action 11:32:06 INFO - Running main action method: read_buildbot_config 11:32:06 INFO - Using buildbot properties: 11:32:06 INFO - { 11:32:06 INFO - "project": "", 11:32:06 INFO - "product": "firefox", 11:32:06 INFO - "who": "philringnalda@gmail.com", 11:32:06 INFO - "installer_path": "public/build/target.tar.bz2", 11:32:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:32:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:32:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 11:32:06 INFO - "stage_platform": "linux64", 11:32:06 INFO - "basedir": "/builds/slave/test", 11:32:06 INFO - "buildnumber": 807, 11:32:06 INFO - "platform": "ubuntu64_hw", 11:32:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:32:06 INFO - "slavebuilddir": "test", 11:32:06 INFO - "taskId": "HDY0KSFvTJmTB20PTO14Iw", 11:32:06 INFO - "branch": "mozilla-central", 11:32:06 INFO - "script_repo_revision": "production", 11:32:06 INFO - "revision": "71224049c0b52ab190564d3ea0eab089a159a4cf", 11:32:06 INFO - "slavename": "talos-linux64-ix-010", 11:32:06 INFO - "repo_path": "mozilla-central" 11:32:06 INFO - } 11:32:06 INFO - Finding installer, test and symbols from parent task. 11:32:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDY0KSFvTJmTB20PTO14Iw'}, attempt #1 11:32:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDY0KSFvTJmTB20PTO14Iw'}, attempt #1 11:32:07 INFO - Task dependencies: HGkBkDAMQNCn5pyZaisZlA 11:32:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA'}, attempt #1 11:32:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.tar.bz2 11:32:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/test_packages.json 11:32:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.crashreporter-symbols.zip 11:32:07 INFO - Running post-action listener: _resource_record_post_action 11:32:07 INFO - [mozharness: 2017-01-29 19:32:07.502660Z] Finished read-buildbot-config step (success) 11:32:07 INFO - [mozharness: 2017-01-29 19:32:07.502878Z] Running download-and-extract step. 11:32:07 INFO - Running pre-action listener: _resource_record_pre_action 11:32:07 INFO - Running main action method: download_and_extract 11:32:07 INFO - mkdir: /builds/slave/test/build/tests 11:32: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')]} 11:32:07 INFO - trying https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.test_packages.json 11:32:07 INFO - Downloading https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:32:08 INFO - Downloaded 896 bytes. 11:32:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:32:08 INFO - Using the following test package requirements: 11:32:08 INFO - {u'common': [u'target.common.tests.zip'], 11:32:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:32:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:32:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:32:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:32:08 INFO - u'mozbase': [u'target.common.tests.zip'], 11:32:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:32:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:32:08 INFO - u'web-platform': [u'target.common.tests.zip', 11:32:08 INFO - u'target.web-platform.tests.zip'], 11:32:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:32:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:32:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.common.tests.zip 11:32:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:32:08 INFO - Fetch https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.common.tests.zip into memory 11:32:08 INFO - Expected file size: 20332783 11:32:08 INFO - Obtained file size: 20332783 11:32:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:32:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.common.tests.zip 11:32:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:32:12 INFO - Fetch https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.common.tests.zip into memory 11:32:13 INFO - Expected file size: 20332783 11:32:13 INFO - Obtained file size: 20332783 11:32:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.talos.tests.zip 11:32:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:32:18 INFO - Fetch https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.talos.tests.zip into memory 11:32:18 INFO - Expected file size: 14403454 11:32:18 INFO - Obtained file size: 14403454 11:32: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')]} 11:32:19 INFO - trying https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.tar.bz2 11:32:19 INFO - Downloading https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:32:20 INFO - Downloaded 56242191 bytes. 11:32:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.tar.bz2 11:32:20 INFO - mkdir: /builds/slave/test/properties 11:32:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:32:20 INFO - Writing to file /builds/slave/test/properties/build_url 11:32:20 INFO - Contents: 11:32:20 INFO - build_url:https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.tar.bz2 11:32:20 INFO - Running post-action listener: _resource_record_post_action 11:32:20 INFO - Running post-action listener: set_extra_try_arguments 11:32:20 INFO - [mozharness: 2017-01-29 19:32:20.321617Z] Finished download-and-extract step (success) 11:32:20 INFO - [mozharness: 2017-01-29 19:32:20.321715Z] Running populate-webroot step. 11:32:20 INFO - Running pre-action listener: _resource_record_pre_action 11:32:20 INFO - Running main action method: populate_webroot 11:32:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:32:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:32:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:32:20 INFO - '--tppagecycles', 11:32:20 INFO - '7'], 11:32:20 INFO - 'tests': ['tsvgm']}}, 11:32:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:32:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:32:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:32:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:32:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:32:20 INFO - 'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:32:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:32:20 INFO - 'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['damp', 'tps']}, 11:32:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:32:20 INFO - 'tests': ['damp', 'tps']}, 11:32:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['dromaeo_dom']}, 11:32:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:32:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['basic_compositor_video']}, 11:32:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:32:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['a11yr', 11:32:20 INFO - 'ts_paint', 11:32:20 INFO - 'tpaint', 11:32:20 INFO - 'sessionrestore', 11:32:20 INFO - 'sessionrestore_no_auto_restore', 11:32:20 INFO - 'tabpaint']}, 11:32:20 INFO - 'other-e10s': {'tests': ['a11yr', 11:32:20 INFO - 'ts_paint', 11:32:20 INFO - 'tpaint', 11:32:20 INFO - 'sessionrestore', 11:32:20 INFO - 'sessionrestore_no_auto_restore', 11:32:20 INFO - 'tabpaint']}, 11:32:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:32:20 INFO - 'ts_paint', 11:32:20 INFO - 'tpaint', 11:32:20 INFO - 'sessionrestore', 11:32:20 INFO - 'sessionrestore_no_auto_restore', 11:32:20 INFO - 'tabpaint']}, 11:32:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:32:20 INFO - 'ts_paint', 11:32:20 INFO - 'tpaint', 11:32:20 INFO - 'sessionrestore', 11:32:20 INFO - 'sessionrestore_no_auto_restore', 11:32:20 INFO - 'tabpaint']}, 11:32:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['a11yr', 11:32:20 INFO - 'ts_paint', 11:32:20 INFO - 'tpaint', 11:32:20 INFO - 'sessionrestore', 11:32:20 INFO - 'sessionrestore_no_auto_restore', 11:32:20 INFO - 'tabpaint']}, 11:32:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['a11yr', 11:32:20 INFO - 'ts_paint', 11:32:20 INFO - 'tpaint', 11:32:20 INFO - 'sessionrestore', 11:32:20 INFO - 'sessionrestore_no_auto_restore', 11:32:20 INFO - 'tabpaint']}, 11:32:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['tsvgx', 11:32:20 INFO - 'tsvgr_opacity', 11:32:20 INFO - 'tart', 11:32:20 INFO - 'tscrollx', 11:32:20 INFO - 'cart', 11:32:20 INFO - 'tsvg_static']}, 11:32:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:32:20 INFO - 'tsvgr_opacity', 11:32:20 INFO - 'tart', 11:32:20 INFO - 'tscrollx', 11:32:20 INFO - 'cart', 11:32:20 INFO - 'tsvg_static']}, 11:32:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:32:20 INFO - 'talos_options': ['--disable-e10s'], 11:32:20 INFO - 'tests': ['tp5o']}, 11:32:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:32:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:32:20 INFO - 'talos_options': ['--disable-e10s', 11:32:20 INFO - '--xperf_path', 11:32:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:20 INFO - 'tests': ['tp5n']}, 11:32:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:32:20 INFO - 'talos_options': ['--xperf_path', 11:32:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:20 INFO - 'tests': ['tp5n']}}, 11:32:20 INFO - 'talos.zip': {'path': '', 11:32:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:32:20 INFO - Running post-action listener: _resource_record_post_action 11:32:20 INFO - [mozharness: 2017-01-29 19:32:20.334818Z] Finished populate-webroot step (success) 11:32:20 INFO - [mozharness: 2017-01-29 19:32:20.334911Z] Running create-virtualenv step. 11:32:20 INFO - Running pre-action listener: _resource_record_pre_action 11:32:20 INFO - Running main action method: create_virtualenv 11:32:20 INFO - Creating virtualenv /builds/slave/test/build/venv 11:32:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:32:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:32:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:32:20 INFO - Using real prefix '/usr' 11:32:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:32:20 INFO - Installing distribute.............................................................................................................................................................................................done. 11:32:22 INFO - Installing pip.................done. 11:32:22 INFO - Return code: 0 11:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:32:23 INFO - Reading from file tmpfile_stdout 11:32:23 INFO - Output received: 11:32:23 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:32:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1761a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32: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', 'pip>=1.5'] in /builds/slave/test/build 11:32: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 pip>=1.5 11:32:23 INFO - Using env: {'DISPLAY': ':0', 11:32:23 INFO - 'HOME': '/home/cltbld', 11:32:23 INFO - 'LANG': 'en_US.UTF-8', 11:32:23 INFO - 'LANGUAGE': 'en_US:en', 11:32:23 INFO - 'LOGNAME': 'cltbld', 11:32:23 INFO - 'MAIL': '/var/mail/cltbld', 11:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:23 INFO - 'MOZ_NO_REMOTE': '1', 11:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:23 INFO - 'NO_EM_RESTART': '1', 11:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:23 INFO - 'PWD': '/builds/slave/test', 11:32:23 INFO - 'SHELL': '/bin/bash', 11:32:23 INFO - 'SHLVL': '1', 11:32:23 INFO - 'TERM': 'linux', 11:32:23 INFO - 'TMOUT': '86400', 11:32:23 INFO - 'USER': 'cltbld', 11:32:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:23 INFO - '_': '/tools/buildbot/bin/python'} 11:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:32:23 INFO - Cleaning up... 11:32:23 INFO - Return code: 0 11:32:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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', '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 0x16511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1761a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:32: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 psutil>=3.1.1 11:32:23 INFO - Using env: {'DISPLAY': ':0', 11:32:23 INFO - 'HOME': '/home/cltbld', 11:32:23 INFO - 'LANG': 'en_US.UTF-8', 11:32:23 INFO - 'LANGUAGE': 'en_US:en', 11:32:23 INFO - 'LOGNAME': 'cltbld', 11:32:23 INFO - 'MAIL': '/var/mail/cltbld', 11:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:23 INFO - 'MOZ_NO_REMOTE': '1', 11:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:23 INFO - 'NO_EM_RESTART': '1', 11:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:23 INFO - 'PWD': '/builds/slave/test', 11:32:23 INFO - 'SHELL': '/bin/bash', 11:32:23 INFO - 'SHLVL': '1', 11:32:23 INFO - 'TERM': 'linux', 11:32:23 INFO - 'TMOUT': '86400', 11:32:23 INFO - 'USER': 'cltbld', 11:32:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:23 INFO - '_': '/tools/buildbot/bin/python'} 11:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:23 INFO - Downloading/unpacking psutil>=3.1.1 11:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:32:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:25 INFO - Installing collected packages: psutil 11:32:25 INFO - Running setup.py install for psutil 11:32:25 INFO - building 'psutil._psutil_linux' extension 11:32:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:32:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:32:25 INFO - building 'psutil._psutil_posix' extension 11:32:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:32:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:32:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:26 INFO - Successfully installed psutil 11:32:26 INFO - Cleaning up... 11:32:26 INFO - Return code: 0 11:32:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1761a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:32:26 INFO - Using env: {'DISPLAY': ':0', 11:32:26 INFO - 'HOME': '/home/cltbld', 11:32:26 INFO - 'LANG': 'en_US.UTF-8', 11:32:26 INFO - 'LANGUAGE': 'en_US:en', 11:32:26 INFO - 'LOGNAME': 'cltbld', 11:32:26 INFO - 'MAIL': '/var/mail/cltbld', 11:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:26 INFO - 'MOZ_NO_REMOTE': '1', 11:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:26 INFO - 'NO_EM_RESTART': '1', 11:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:26 INFO - 'PWD': '/builds/slave/test', 11:32:26 INFO - 'SHELL': '/bin/bash', 11:32:26 INFO - 'SHLVL': '1', 11:32:26 INFO - 'TERM': 'linux', 11:32:26 INFO - 'TMOUT': '86400', 11:32:26 INFO - 'USER': 'cltbld', 11:32:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:26 INFO - '_': '/tools/buildbot/bin/python'} 11:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:32:28 INFO - Installing collected packages: mozsystemmonitor 11:32:28 INFO - Running setup.py install for mozsystemmonitor 11:32:28 INFO - Successfully installed mozsystemmonitor 11:32:28 INFO - Cleaning up... 11:32:28 INFO - Return code: 0 11:32:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:28 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 0x16511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1761a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:32:28 INFO - Using env: {'DISPLAY': ':0', 11:32:28 INFO - 'HOME': '/home/cltbld', 11:32:28 INFO - 'LANG': 'en_US.UTF-8', 11:32:28 INFO - 'LANGUAGE': 'en_US:en', 11:32:28 INFO - 'LOGNAME': 'cltbld', 11:32:28 INFO - 'MAIL': '/var/mail/cltbld', 11:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:28 INFO - 'MOZ_NO_REMOTE': '1', 11:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:28 INFO - 'NO_EM_RESTART': '1', 11:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:28 INFO - 'PWD': '/builds/slave/test', 11:32:28 INFO - 'SHELL': '/bin/bash', 11:32:28 INFO - 'SHLVL': '1', 11:32:28 INFO - 'TERM': 'linux', 11:32:28 INFO - 'TMOUT': '86400', 11:32:28 INFO - 'USER': 'cltbld', 11:32:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:28 INFO - '_': '/tools/buildbot/bin/python'} 11:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:28 INFO - Downloading/unpacking jsonschema==2.5.1 11:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:31 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:31 INFO - warning: no files found matching '*.txt' 11:32:31 INFO - no previously-included directories found matching 'build' 11:32:31 INFO - no previously-included directories found matching 'dist' 11:32:31 INFO - no previously-included directories found matching '.git*' 11:32:31 INFO - Installing collected packages: jsonschema, functools32 11:32:31 INFO - Running setup.py install for functools32 11:32:31 INFO - warning: no files found matching '*.txt' 11:32:31 INFO - no previously-included directories found matching 'build' 11:32:31 INFO - no previously-included directories found matching 'dist' 11:32:31 INFO - no previously-included directories found matching '.git*' 11:32:31 INFO - Successfully installed jsonschema functools32 11:32:31 INFO - Cleaning up... 11:32:31 INFO - Return code: 0 11:32:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:31 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 0x16511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1761a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:32:31 INFO - Using env: {'DISPLAY': ':0', 11:32:31 INFO - 'HOME': '/home/cltbld', 11:32:31 INFO - 'LANG': 'en_US.UTF-8', 11:32:31 INFO - 'LANGUAGE': 'en_US:en', 11:32:31 INFO - 'LOGNAME': 'cltbld', 11:32:31 INFO - 'MAIL': '/var/mail/cltbld', 11:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:31 INFO - 'MOZ_NO_REMOTE': '1', 11:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:31 INFO - 'NO_EM_RESTART': '1', 11:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:31 INFO - 'PWD': '/builds/slave/test', 11:32:31 INFO - 'SHELL': '/bin/bash', 11:32:31 INFO - 'SHLVL': '1', 11:32:31 INFO - 'TERM': 'linux', 11:32:31 INFO - 'TMOUT': '86400', 11:32:31 INFO - 'USER': 'cltbld', 11:32:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:31 INFO - '_': '/tools/buildbot/bin/python'} 11:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:32:31 INFO - Cleaning up... 11:32:31 INFO - Return code: 0 11:32:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:31 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 0x16511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1761a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:32:31 INFO - Using env: {'DISPLAY': ':0', 11:32:31 INFO - 'HOME': '/home/cltbld', 11:32:31 INFO - 'LANG': 'en_US.UTF-8', 11:32:31 INFO - 'LANGUAGE': 'en_US:en', 11:32:31 INFO - 'LOGNAME': 'cltbld', 11:32:31 INFO - 'MAIL': '/var/mail/cltbld', 11:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:31 INFO - 'MOZ_NO_REMOTE': '1', 11:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:31 INFO - 'NO_EM_RESTART': '1', 11:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:31 INFO - 'PWD': '/builds/slave/test', 11:32:31 INFO - 'SHELL': '/bin/bash', 11:32:31 INFO - 'SHLVL': '1', 11:32:31 INFO - 'TERM': 'linux', 11:32:31 INFO - 'TMOUT': '86400', 11:32:31 INFO - 'USER': 'cltbld', 11:32:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:31 INFO - '_': '/tools/buildbot/bin/python'} 11:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:31 INFO - Downloading/unpacking blobuploader==1.2.4 11:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:33 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:32:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:34 INFO - Downloading docopt-0.6.1.tar.gz 11:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:34 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:34 INFO - Running setup.py install for blobuploader 11:32:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:32:34 INFO - Running setup.py install for requests 11:32:35 INFO - Running setup.py install for docopt 11:32:35 INFO - Successfully installed blobuploader requests docopt 11:32:35 INFO - Cleaning up... 11:32:35 INFO - Return code: 0 11:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:35 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 0x16511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1761a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:32:35 INFO - Using env: {'DISPLAY': ':0', 11:32:35 INFO - 'HOME': '/home/cltbld', 11:32:35 INFO - 'LANG': 'en_US.UTF-8', 11:32:35 INFO - 'LANGUAGE': 'en_US:en', 11:32:35 INFO - 'LOGNAME': 'cltbld', 11:32:35 INFO - 'MAIL': '/var/mail/cltbld', 11:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:35 INFO - 'MOZ_NO_REMOTE': '1', 11:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:35 INFO - 'NO_EM_RESTART': '1', 11:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:35 INFO - 'PWD': '/builds/slave/test', 11:32:35 INFO - 'SHELL': '/bin/bash', 11:32:35 INFO - 'SHLVL': '1', 11:32:35 INFO - 'TERM': 'linux', 11:32:35 INFO - 'TMOUT': '86400', 11:32:35 INFO - 'USER': 'cltbld', 11:32:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:35 INFO - '_': '/tools/buildbot/bin/python'} 11:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:35 INFO - Running setup.py (path:/tmp/pip-o2l8jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:35 INFO - Running setup.py (path:/tmp/pip-yX0WOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:35 INFO - Running setup.py (path:/tmp/pip-KrFNPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:35 INFO - Running setup.py (path:/tmp/pip-1BUTzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:35 INFO - Running setup.py (path:/tmp/pip-ad2Evi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:35 INFO - Running setup.py (path:/tmp/pip-ZJ2RiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:35 INFO - Running setup.py (path:/tmp/pip-Dz2w_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:35 INFO - Running setup.py (path:/tmp/pip-vQhGSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:36 INFO - Running setup.py (path:/tmp/pip-b3ZQkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:36 INFO - Running setup.py (path:/tmp/pip-AlOWW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:36 INFO - Running setup.py (path:/tmp/pip-aLj4wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:36 INFO - Running setup.py (path:/tmp/pip-YQT_nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:36 INFO - Running setup.py (path:/tmp/pip-rw1NkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:36 INFO - Running setup.py (path:/tmp/pip-GGwQzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:36 INFO - Running setup.py (path:/tmp/pip-T7fSGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:36 INFO - Running setup.py (path:/tmp/pip-nIVgy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:36 INFO - Running setup.py (path:/tmp/pip-eDiaXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:36 INFO - Running setup.py install for manifestparser 11:32:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:36 INFO - Running setup.py install for mozcrash 11:32:36 INFO - Running setup.py install for mozdebug 11:32:36 INFO - Running setup.py install for mozdevice 11:32:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:32:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:37 INFO - Running setup.py install for mozfile 11:32:37 INFO - Running setup.py install for mozhttpd 11:32:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:37 INFO - Running setup.py install for mozinfo 11:32:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:37 INFO - Running setup.py install for mozInstall 11:32:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:37 INFO - Running setup.py install for mozleak 11:32:37 INFO - Running setup.py install for mozlog 11:32:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:37 INFO - Running setup.py install for moznetwork 11:32:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:37 INFO - Running setup.py install for mozprocess 11:32:37 INFO - Running setup.py install for mozprofile 11:32:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Running setup.py install for mozrunner 11:32:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Running setup.py install for mozscreenshot 11:32:38 INFO - Running setup.py install for moztest 11:32:38 INFO - Running setup.py install for mozversion 11:32:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:38 INFO - Cleaning up... 11:32:38 INFO - Return code: 0 11:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:38 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 0x16511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1761a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:32:38 INFO - Using env: {'DISPLAY': ':0', 11:32:38 INFO - 'HOME': '/home/cltbld', 11:32:38 INFO - 'LANG': 'en_US.UTF-8', 11:32:38 INFO - 'LANGUAGE': 'en_US:en', 11:32:38 INFO - 'LOGNAME': 'cltbld', 11:32:38 INFO - 'MAIL': '/var/mail/cltbld', 11:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:38 INFO - 'MOZ_NO_REMOTE': '1', 11:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:38 INFO - 'NO_EM_RESTART': '1', 11:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:38 INFO - 'PWD': '/builds/slave/test', 11:32:38 INFO - 'SHELL': '/bin/bash', 11:32:38 INFO - 'SHLVL': '1', 11:32:38 INFO - 'TERM': 'linux', 11:32:38 INFO - 'TMOUT': '86400', 11:32:38 INFO - 'USER': 'cltbld', 11:32:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:38 INFO - '_': '/tools/buildbot/bin/python'} 11:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:38 INFO - Running setup.py (path:/tmp/pip-wVLGq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:38 INFO - Running setup.py (path:/tmp/pip-G6AebF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:38 INFO - Running setup.py (path:/tmp/pip-7Rl2wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:38 INFO - Running setup.py (path:/tmp/pip-BD9G4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:39 INFO - Running setup.py (path:/tmp/pip-NY0WnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:39 INFO - Running setup.py (path:/tmp/pip-21DXzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:39 INFO - Running setup.py (path:/tmp/pip-YAh4PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:39 INFO - Running setup.py (path:/tmp/pip-uQ_Atv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:39 INFO - Running setup.py (path:/tmp/pip-8dJVbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:39 INFO - Running setup.py (path:/tmp/pip-GqTMOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:39 INFO - Running setup.py (path:/tmp/pip-pcFaHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:39 INFO - Running setup.py (path:/tmp/pip-2XaSRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:39 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)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:39 INFO - Running setup.py (path:/tmp/pip-tn6Q0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:39 INFO - Running setup.py (path:/tmp/pip-SsblO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:39 INFO - Running setup.py (path:/tmp/pip-5WPJMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:39 INFO - Running setup.py (path:/tmp/pip-KWsbFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:39 INFO - Running setup.py (path:/tmp/pip-bvmPOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:41 INFO - Downloading blessings-1.6.tar.gz 11:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:42 INFO - Installing collected packages: blessings 11:32:42 INFO - Running setup.py install for blessings 11:32:42 INFO - Successfully installed blessings 11:32:42 INFO - Cleaning up... 11:32:42 INFO - Return code: 0 11:32:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:42 INFO - Reading from file tmpfile_stdout 11:32:42 INFO - Current package versions: 11:32:42 INFO - argparse == 1.2.1 11:32:42 INFO - blessings == 1.6 11:32:42 INFO - blobuploader == 1.2.4 11:32:42 INFO - docopt == 0.6.1 11:32:42 INFO - functools32 == 3.2.3-2 11:32:42 INFO - jsonschema == 2.5.1 11:32:42 INFO - manifestparser == 1.1 11:32:42 INFO - mozInstall == 1.12 11:32:42 INFO - mozcrash == 1.0 11:32:42 INFO - mozdebug == 0.1 11:32:42 INFO - mozdevice == 0.49 11:32:42 INFO - mozfile == 1.2 11:32:42 INFO - mozhttpd == 0.7 11:32:42 INFO - mozinfo == 0.9 11:32:42 INFO - mozleak == 0.1 11:32:42 INFO - mozlog == 3.4 11:32:42 INFO - moznetwork == 0.27 11:32:42 INFO - mozprocess == 0.24 11:32:42 INFO - mozprofile == 0.28 11:32:42 INFO - mozrunner == 6.13 11:32:42 INFO - mozscreenshot == 0.1 11:32:42 INFO - mozsystemmonitor == 0.3 11:32:42 INFO - moztest == 0.8 11:32:42 INFO - mozversion == 1.4 11:32:42 INFO - psutil == 3.1.1 11:32:42 INFO - requests == 1.2.3 11:32:42 INFO - wsgiref == 0.1.2 11:32:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:42 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 0x16511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1761a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:32:42 INFO - Using env: {'DISPLAY': ':0', 11:32:42 INFO - 'HOME': '/home/cltbld', 11:32:42 INFO - 'LANG': 'en_US.UTF-8', 11:32:42 INFO - 'LANGUAGE': 'en_US:en', 11:32:42 INFO - 'LOGNAME': 'cltbld', 11:32:42 INFO - 'MAIL': '/var/mail/cltbld', 11:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:42 INFO - 'MOZ_NO_REMOTE': '1', 11:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:42 INFO - 'NO_EM_RESTART': '1', 11:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:42 INFO - 'PWD': '/builds/slave/test', 11:32:42 INFO - 'SHELL': '/bin/bash', 11:32:42 INFO - 'SHLVL': '1', 11:32:42 INFO - 'TERM': 'linux', 11:32:42 INFO - 'TMOUT': '86400', 11:32:42 INFO - 'USER': 'cltbld', 11:32:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:42 INFO - '_': '/tools/buildbot/bin/python'} 11:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:32:42 INFO - Cleaning up... 11:32:42 INFO - Return code: 0 11:32:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1761a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:32:42 INFO - Using env: {'DISPLAY': ':0', 11:32:42 INFO - 'HOME': '/home/cltbld', 11:32:42 INFO - 'LANG': 'en_US.UTF-8', 11:32:42 INFO - 'LANGUAGE': 'en_US:en', 11:32:42 INFO - 'LOGNAME': 'cltbld', 11:32:42 INFO - 'MAIL': '/var/mail/cltbld', 11:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:42 INFO - 'MOZ_NO_REMOTE': '1', 11:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:42 INFO - 'NO_EM_RESTART': '1', 11:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:42 INFO - 'PWD': '/builds/slave/test', 11:32:42 INFO - 'SHELL': '/bin/bash', 11:32:42 INFO - 'SHLVL': '1', 11:32:42 INFO - 'TERM': 'linux', 11:32:42 INFO - 'TMOUT': '86400', 11:32:42 INFO - 'USER': 'cltbld', 11:32:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:42 INFO - '_': '/tools/buildbot/bin/python'} 11:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:32:42 INFO - Cleaning up... 11:32:42 INFO - Return code: 0 11:32:42 INFO - Running post-action listener: _resource_record_post_action 11:32:42 INFO - Running post-action listener: _start_resource_monitoring 11:32:42 INFO - Starting resource monitoring. 11:32:42 INFO - [mozharness: 2017-01-29 19:32:42.913823Z] Finished create-virtualenv step (success) 11:32:42 INFO - [mozharness: 2017-01-29 19:32:42.914385Z] Running install step. 11:32:42 INFO - Running pre-action listener: _resource_record_pre_action 11:32:42 INFO - Running main action method: install 11:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:43 INFO - Reading from file tmpfile_stdout 11:32:43 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:43 INFO - Reading from file tmpfile_stdout 11:32:43 INFO - Output received: 11:32:43 INFO - Usage: mozinstall [options] installer 11:32:43 INFO - Options: 11:32:43 INFO - -h, --help show this help message and exit 11:32:43 INFO - -d DEST, --destination=DEST 11:32:43 INFO - Directory to install application into. [default: 11:32:43 INFO - "/builds/slave/test"] 11:32:43 INFO - --app=APP Application being installed. [default: firefox] 11:32:43 INFO - mkdir: /builds/slave/test/build/application 11:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:33:00 INFO - Reading from file tmpfile_stdout 11:33:00 INFO - Output received: 11:33:00 INFO - /builds/slave/test/build/application/firefox/firefox 11:33:00 INFO - Running post-action listener: _resource_record_post_action 11:33:00 INFO - [mozharness: 2017-01-29 19:33:00.068164Z] Finished install step (success) 11:33:00 INFO - [mozharness: 2017-01-29 19:33:00.068440Z] Running run-tests step. 11:33:00 INFO - Running pre-action listener: _resource_record_pre_action 11:33:00 INFO - Running main action method: run_tests 11:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:33:00 INFO - Python 2.7.3 11:33:00 INFO - Return code: 0 11:33:00 INFO - grabbing minidump binary from tooltool 11:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:00 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 0x1a4c850>, '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 0x19c16d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:33:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:33:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:33:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:33:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:33:00 INFO - Return code: 0 11:33:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:33:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:33:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:33:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:33:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:33:00 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/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:33:00 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/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:33:00 INFO - Using env: {'DISPLAY': ':0', 11:33:00 INFO - 'HOME': '/home/cltbld', 11:33:00 INFO - 'LANG': 'en_US.UTF-8', 11:33:00 INFO - 'LANGUAGE': 'en_US:en', 11:33:00 INFO - 'LOGNAME': 'cltbld', 11:33:00 INFO - 'MAIL': '/var/mail/cltbld', 11:33:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:33:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:00 INFO - 'MOZ_NO_REMOTE': '1', 11:33:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:00 INFO - 'NO_EM_RESTART': '1', 11:33:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:00 INFO - 'PWD': '/builds/slave/test', 11:33:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:33:00 INFO - 'SHELL': '/bin/bash', 11:33:00 INFO - 'SHLVL': '1', 11:33:00 INFO - 'TERM': 'linux', 11:33:00 INFO - 'TMOUT': '86400', 11:33:00 INFO - 'USER': 'cltbld', 11:33:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461', 11:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:00 INFO - '_': '/tools/buildbot/bin/python'} 11:33:00 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/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:33:00 INFO - mozversion application_buildid: 20170129185945 11:33:00 INFO - mozversion application_changeset: 71224049c0b52ab190564d3ea0eab089a159a4cf 11:33:00 INFO - mozversion application_display_name: Nightly 11:33:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:33:00 INFO - mozversion application_name: Firefox 11:33:00 INFO - mozversion application_remotingname: firefox 11:33:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:33:00 INFO - mozversion application_vendor: Mozilla 11:33:00 INFO - mozversion application_version: 54.0a1 11:33:00 INFO - mozversion platform_buildid: 20170129185945 11:33:00 INFO - mozversion platform_changeset: 71224049c0b52ab190564d3ea0eab089a159a4cf 11:33:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:33:00 INFO - mozversion platform_version: 54.0a1 11:33:00 INFO - using testdate: 1485718380 11:33:00 INFO - actual date: 1485718380 11:33:00 INFO - starting webserver on 'localhost:51064' 11:33:00 INFO - SUITE-START | Running 2 tests 11:33:00 INFO - TEST-START | dromaeo_css 11:33:00 INFO - operating with platform_type : linux_ 11:33:00 INFO - Initialising browser for dromaeo_css test... 11:33:00 INFO - TEST-INFO | started process 30541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe8YrZv/profile http://localhost:51064/getInfo.html) 11:33:04 INFO - PROCESS | 30541 | 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] 11:33:04 INFO - PROCESS | 30541 | __metrics Screen width/height:1600/1200 11:33:04 INFO - PROCESS | 30541 | colorDepth:24 11:33:04 INFO - PROCESS | 30541 | Browser inner width/height: 1024/697 11:33:04 INFO - PROCESS | 30541 | __metrics 11:33:05 INFO - PROCESS | 30541 | 1485718385307 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 11:33:05 INFO - PROCESS | 30541 | 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" 11:33:05 INFO - PROCESS | 30541 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:33:06 INFO - PROCESS | 30541 | console.error: PushService: 11:33:06 INFO - PROCESS | 30541 | stateChangeProcessEnqueue: Error transitioning state 11:33:06 INFO - PROCESS | 30541 | UnknownError 11:33:06 INFO - TEST-INFO | 30541: exit 0 11:33:06 INFO - Browser initialized. 11:33:06 INFO - Running cycle 1/1 for dromaeo_css test... 11:33:06 INFO - TEST-INFO | started process 30623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe8YrZv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:18 INFO - PROCESS | 30623 | RSS: Main: 157659136 11:33:18 INFO - PROCESS | 30623 | 11:36:24 INFO - PROCESS | 30623 | Cycle 1(1): loaded http://localhost:51064/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51064/tests/dromaeo/cssquery-ext.html) 11:36:25 INFO - PROCESS | 30623 | RSS: Main: 253120512 11:36:25 INFO - PROCESS | 30623 | 11:38:09 INFO - PROCESS | 30623 | ************************* 11:38:09 INFO - PROCESS | 30623 | A coding exception was thrown and uncaught in a Task. 11:38:09 INFO - PROCESS | 30623 | 11:38:09 ERROR - PROCESS | 30623 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:38:09 INFO - PROCESS | 30623 | Full stack: 11:38:09 INFO - PROCESS | 30623 | ************************* 11:39:27 INFO - PROCESS | 30623 | Cycle 1(1): loaded http://localhost:51064/tests/dromaeo/cssquery-ext.html (next: http://localhost:51064/tests/dromaeo/cssquery-jquery.html) 11:39:28 INFO - PROCESS | 30623 | RSS: Main: 241967104 11:39:28 INFO - PROCESS | 30623 | 11:42:30 INFO - PROCESS | 30623 | Cycle 1(1): loaded http://localhost:51064/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51064/tests/dromaeo/cssquery-mootools.html) 11:42:31 INFO - PROCESS | 30623 | RSS: Main: 219930624 11:42:31 INFO - PROCESS | 30623 | 11:45:33 INFO - PROCESS | 30623 | Cycle 1(1): loaded http://localhost:51064/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51064/tests/dromaeo/cssquery-prototype.html) 11:45:34 INFO - PROCESS | 30623 | RSS: Main: 184963072 11:45:34 INFO - PROCESS | 30623 | 11:48:37 INFO - PROCESS | 30623 | Cycle 1(1): loaded http://localhost:51064/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51064/tests/dromaeo/cssquery-yui.html) 11:48:38 INFO - PROCESS | 30623 | RSS: Main: 185348096 11:48:38 INFO - PROCESS | 30623 | 11:51:41 INFO - PROCESS | 30623 | Cycle 1(1): loaded http://localhost:51064/tests/dromaeo/cssquery-yui.html (next: http://localhost:51064/tests/dromaeo/cssquery-dojo.html) 11:51:41 INFO - PROCESS | 30623 | RSS: Main: 276549632 11:51:41 INFO - PROCESS | 30623 | 11:51:41 INFO - PROCESS | 30623 | __start_tp_report 11:51:41 INFO - PROCESS | 30623 | _x_x_mozilla_page_load 11:51:41 INFO - PROCESS | 30623 | _x_x_mozilla_page_load_details 11:51:41 INFO - PROCESS | 30623 | |i|pagename|runs| 11:51:41 INFO - PROCESS | 30623 | |0;dojo.html;2533.7466253374664;2563.0260501009607;2568.1011645923927;2579.8323108997924;2601.0766178006807;4475.104979004196;4511.706739061967;4529.841455549056;4601.447826260849;4632.305154226863;4538.931916021263;4635.814567417299;4658.021815418766;4707.858764237069;4740.383750112489;4218.578142185772;4224.239636865363;4259.723117997336;4308.030693094044;4382.583654552813;4038.6970977176684;4303.419038429804;4357.12857428514;4396.406485124515;4438.289873620221;4192.45498085247;4277.1873344064525;4293.613574778254;4338.175746608134;4351.9782401088105;4180.28935081037;4225.72532785371;4239.894002649928;4252.510961239435;4296.4414626098405;4249.808758605839;4249.80875860587;4290.377895205209;4291.463567054118;4305.526392096866;4599.379083823675;4625.722456652612;4631.722096674211;4654.278586819015;4686.414198225222;4843.685160464559;4902.950970490285;4906.852794416173;4952.727599981999;4960.801567937278;4962.206047032458;4964.304997300344;4979.327790748239;5004.249362595603;5023.171176755831;4623.0522742837975;4662;4667.089917466129;4668.206404911173;4691.577758001797;4945.060438516671;4987.226979818134;5071.340725705709;5074.974625126851;5128.487151284841;4804.159272127364;4833.4441539222735;4836.879078023077;4860.659753817199;4909.705417674951;4864.805407783649;4918.631102667314;4923.75381230937;4934.554843340322;4935.185694360391;4879.780409881564;4893.828715994923;4900.289458028566;4910.729909854921;5008.398992120896;4940.209566469348;4948.851534453972;4960.181570040902;4965.950340496621;4984.77568509418;4104.692148088905;4152.1695660867945;4178.039051018222;4217.030083080847;4252.340887162495;3659.030356955409;3665.1753355495334;3691.667749902522;3692.907677308035;3701.0747313171705;4351.673624478177;4352.1513304905875;4353.629941455012;4358.65130789536;4395.318725597537;4808.879778005507;4862.854114376574;5044.697318160849;5045.899082018339;5096.821611243588;4207.095474473003;4236.449261596034;4245.511766146871;4248.87253382399;4305.203537345601;4411.7573533455325;4415.55608440427;4425.070735145656;4425.203463376559;4457.175422546839;4549.977250113729;4621.468531118964;4632.189366860854;4641.466231383434;4662.044280922402;4879.414470263591;4925.753712314442;4964.3298154748645;4967.3542439482635;4988.27669987857;4665.976670116627;4670.556297151765;4673.392458980311;4675.883102922454;4708.741019243975;4878.390201224847;4881.926771098365;4893.339399181065;4894.849710318002;4943.011397720542;4807;4844.539768721966;4871.90256194867;4896.461389247109;4897.289892965571;4782.904341913212;4787.664863459524;4797.952020479751;4826.155422800925;4831.106245344622;4637;4671.883202919954;4772.069446457907;4783.689060211075;4794.712317260975;4677.438707355139;4756.667033307635;4800.639952003684;4807.254875494304;4851.199552073868;4868.245421959602;4892.779824907817;4894.216925291937;4898.53463920927;4944.678595891256;4762.880927976689;4786.186348320724;4790.089882922233;4791.856244312677;4844.297576851407 11:51:41 INFO - PROCESS | 30623 | |1;ext.html;517.6712787380013;523.910935141026;531.6464551073536;551.9944800551993;563.4534501533511;29431.117066488012;32643.83678081609;32645.5103173452;39044;41600.58399416005;41406.378904316385;41849.37225941613;41921.58078419215;41957.370639440356;41979.37030944531;7721.227877212276;7896.684132634717;7899.091604465502;7902.446828721992;7903.881441778378;7515.436342274324;7700.845983080335;7800.336971357441;10025.197984161287;10318.12295954841;10228.43743594102;10262.9486852566;10288.588456461732;10290.639827606035;10299.27905046647;10151.137153341975;10189.643362482351;10191.59233630654;10216.387016779017;10227.437490937959;10060.597576096947;10118.49407529628;10139.64511242103;10153.984601539862;10165.322721750903;40176.79911600453;40400.39399409011;40442.39336409956;40467;40479;3587.6950459211;3671.2473942841652;3682.9447558286647;3696.4085746280734;3735.719821013408;28413.147605571867;28616.42767144666;28646.570301445496;28901.277468063257;30217.697823021706;3480.32133733922;3513.2446523997464;3543.450765131409;3573.5711714594413;3613.1147868772055;243254;243600;244086;244289;244669.99999999822;55484;55594.72202638961;55840.441595584336;55932.44067559273;55981.720091399286;51488.22767658488;51588.48411515912;59193.40806591879;59225;59284;15571;15844.287007084478;15861.286242119133;15864.52406427809;15867.206639668202;10411.5835366586;11496;11559.190856639954;11562.76874462506;11578.073754099652;15414.152221627694;17240.65518689619;17603.55991100233;17646.470605881845;18294.451166465027;6547.410733034049;6581.736730530725;6607;6728.966355168291;6852.383285504328;719.2447929673822;772.6638912073266;774.5585016540517;776.8640487914705;781.5115552779513;26673.599896001575;28133.296667583065;28380.71619283822;28445.288867778472;28636.284092897844;846.5809424334993;942.4345392764286;967.5549247346158;967.9225661947028;976.2873102635116;14339.569812905422;14927.477538286108;15100.244987750568;15304.617384565476;15532.611684707746;327537;327765;329099;329368;329426;49516.75241623841;49850.750746246034;50774;50937;51307.23039154416;1209.4315671634495;1233.2970206982113;1249.5439164704635;1250.3685638752372;1251.5932321995206;27447;28808.567871482363;29012.27469313284;29810.403791924473;29813.403731925675;44017;44682;44734.55265447304;44747.77626111849;44749;296979;298949;299005;299610;299881;23744.40638984039;24512.50974980526;24590.262292131265;36955.260894781415;37294.9487778164;34077.82961085179;35115.29769404547;36113.63886361103;36331.818340908125;38563.2287354257;32787.34425311528;33749;33791;34045.319093617494;34335.313293734485;33139.66860331366;33270.33459330751;33351.33297334088;33381.83309083439;34097.31805363829;32532.34935301328;33111.33777324392;33237.667623323454;33488.66511334856;33572.32855342928;26727;29893.252668683457;30056.69943300539;30234.697653023188;30391.848040759654;22950.19674311391;23422.64866026977;23434.414139646644;23441.179558715365;23567.646485303077 11:51:41 INFO - PROCESS | 30623 | |2;jquery.html;375.98872033838995;386.25067369303565;398.5436675007117;400.7935913004802;412.35466494935423;13713.493713493708;13913;16910.06994615296;18571.442856714286;18598.163082661296;14387.280635968213;14790.408383664668;17447.389341373055;17531.91234043828;17673.469795906145;4994.725290109042;5166.638335316529;5227.320448341729;5267.815626453075;5277.182036784286;5216.7391630418515;5292.285541451913;5296.735163241822;5301.416844147141;5301.814436494724;5113.181890897457;5190.740462976836;5252.054630166568;5253.816116435925;5255.02781985334;5115.335006449175;5137.61467889906;5138.434772175039;5163.277141200235;5166.948330516684;4554.795034223468;4721.858344249678;4753.643476739224;4755.595774359183;4757.857264282077;19626.50933726654;19959.101840417217;20114.69827952582;21447.35657930249;21761.782382176134;1988.532694816717;2035.6539388304025;2046.9590608187902;2050.958980820375;2086.739157605299;9207.125323094362;9344.159025687653;9784.168345690625;10238.641647542301;13416.86583134166;1679.2863033210836;1703.0733048989587;1734.6097128146193;1761.339497688367;1781.3052909365358;77698.22301777023;79008;80564.59717701432;81138.59430702809;83820.58089709573;10627.946860265803;10868.836967445337;10940.4529773511;11085.22403431752;11138.3873886937;15099.849001509845;15210.619734506727;15249.3900243989;15254.08475491474;15254.694906101815;6801.081853949752;7129;7642.770716878503;7818.179091195457;8063.959680201561;6862.279460656659;6984.720611175598;7133.322334378226;7143.678534465961;7596.924030759732;8917.687880924266;9094.954525227464;9131.178193962574;9248.630054797733;9479.620815167316;3348.1294863335706;3825.6748176405317;3894;3896.6298201670797;4002.1795531915886;923.4736200365727;955.2024059909915;956.1251454918811;958.4728399380452;965.0976337124671;16208.675826483404;16216.351345946267;16750.581235468966;17358.91320543389;17668.734968975477;943.3349488610513;944.7165850245036;945.3288165402504;951.990480095204;955.47926380123;9748.2046723464;9750.658726944523;9762.560684769202;9788.657396991213;9808.852867206997;495411;498384;503074;513059;516155;67759;92848;95884;96376.59058523593;96780;925.2043242811043;943.8867335919596;956.7225504603726;961.3991255465335;962.432165022626;14725;14867.628309291922;14956.252187390804;15094.54716358511;15561.076852461742;40174;40606.79696601498;41621.79189104035;41825.37261941134;42784.786076069424;54071.45928540664;54560.454395455534;56620.43379566151;57515.71242143762;59023.704881475314;5714.714264286852;7847.84304313922;8126.512409255227;8216.274582337775;8287.668493260202;11301.26541774782;12026.639200823989;12124.211926224767;12168;12290.81563776562;9925;10040.548175331982;10327.638532651621;10372.74068148272;10385.792284154426;10253.333533320609;10585.735356616146;10591.4704264788;10781.838272425763;10895.891041089804;10551.841722374016;10568.481123792728;10618.61081256711;10651.201159912882;10976.890231097586;7296.160941491797;7337.816554585965;7363.226861179499;8189.549574773445;8283.337333013224;10141.326681097536;10466.529006194893;10582.788344233226;11120.221584489009;11422.086233101165 11:51:41 INFO - PROCESS | 30623 | |3;mootools.html;1286.398085360989;1288.8324517812682;1289.2715615677148;1295.0999055656316;1301.6550614087262;6759;7141;7151.14186297645;7159.069320988271;7174.354308112269;6296.8740625187465;6531.967340163293;6730.427913627347;6993.755218567351;7026.718931242757;2040.8775473471603;2104.8210902073342;2108.1040557762967;2110.3141479019305;2110.48293168174;2099.8737480850127;2119.9788002120013;2125.829933605308;2129.7337832770904;2134.573085382922;1807.6203997160612;1861.7858946221154;1921.0874834453662;1977.6539105656452;2086.488810241485;2036;2045.3966080006285;2047.2322878920404;2047.3550831488033;2049.92825251117;1989.8408127349921;2023.6559784836613;2029.7056926745686;2034.7049677796786;2093.1941202637095;7014.263502332284;7060.435165186773;7061.9293807062295;7065.858682826366;7072.929270707278;4337.132573485315;4460.620847227957;4468.955310446887;4471.128130014648;4474.709143905636;2681.2894582935537;2851.3156842357685;2895.4788138135127;2900.0284904556997;2904.7676185905075;1063.3460421840512;1099.2470157941755;1120.6077872744556;1170.7365842685413;1175.9647210583696;9141.634334626608;9344.06559344067;9353.438793672402;9382.5308734563;9384.812303753886;3824.8661296854475;3982.522097348337;3985.2826491231276;4049.8380064797666;4052.1490486997473;7961.243681850215;7963.442559020813;7963.641636126388;7966.283034526805;7978.042634883851;4389.144116897174;4391.626711729475;4394.231009573312;4394.538573449741;4395.824167033346;3657.487951686766;3775.1505911170316;3962.108525581779;4047.2310261050307;4141.97929010353;3405.7105146062368;3411.096059544223;3562.5546806649168;3563.3051554946537;3573.4997100405963;1165.5745652836654;1180.4569897847086;1196.9222000569935;1200.2138599217526;1201.9158658893969;787.4094429178116;792.0693185507006;799.808046068951;806.5523634382973;810.9107998120202;4427.557244275611;4432.822687092545;4530.161920044737;4624.884377890512;4711.340412342275;532.3611666000814;551.3631755322609;833.1793183714037;874.6632546469655;880.1594477274188;2967.9109626711233;3035.210845180269;3082.583851180062;3101.3332133591384;3103;8128.552929588929;8303;8356.498610083292;8392.076871544125;8396.580170991427;8195.71315003972;8276.668933242603;8293.377996650275;8301.211384918422;8313.916860831436;6459.838504037437;6467.902981455282;6478.740850365933;6566.737330506822;6571.67141642916;4499.797509112163;4516.503184649751;4595.218812801765;4613.008203236186;4737.265723812815;7476.439267054884;7483.176850546544;7542.698292068256;7656.506981138848;7664.195259497673;7630;7838.725644602411;7840.137584865774;7860.84278314442;7868.409869259943;5435.592330575144;5580.748866301107;5775.249217601685;5937.881242375215;5949;6411.262704789009;6681.966590167018;6687.933120668731;6877.3810357068105;6887.070245516791;6125.111858780541;6206.689665516797;6285.088662143872;6329.746810127727;6410.038494225903;6091.116788065794;6133.141360209664;6152.354002829638;6156.6921653918025;6162.168107305636;5471.425500322568;5586.38549759518;5592.245046918614;5592.636478628876;5597.580181486323;3814.9809250953567;3876.2635099331037;3923.313420151405;3966.2265858157384;4031.032552187395;3919.5492518359615;3974.7615143091507;4016.779077150785;4032.173404452139;4108.281050816155 11:51:41 INFO - PROCESS | 30623 | |4;prototype.html;347.90432631026465;355.09450900204473;359.5631307960827;360.1644185489664;363.2788914005698;4753.857384278473;4819.277108433736;4824.565789078983;4842.443119041312;4847.369841920546;4709.364235828162;4752.500987396325;4763;4766.712987493374;4770.451398089221;3686.4654625079347;3775.263823554408;3832.405977073558;3833.252515759428;3838.692904567628;3844.8654297099606;3847.442120892469;3882.611738826123;3882.9029274268087;3894.6300101490456;3826.1582451860545;3827.7320587558884;3839.827207775643;3869.2068126034237;3875.4961854958815;3695.150115473443;3739.5699494558203;3785.7539259948016;3832.7317087803863;3845.5962123977138;3495.615482296945;3499.5100685903994;3501.3172431375892;3504.316658251642;3505.4917037029486;4646.955339650577;4661.510541393172;4661.88345291367;4700.4594471635855;4707.129181101507;4272.166927449149;4417.624501917308;4430.4240448741775;4434.401355816988;4439.844605438827;4980;4989.750512474362;4995.200767877159;4996.625253106032;5029.748512574357;3804.2201348723447;3807.505024346845;3820.726667632754;3827.9234415311817;3831.7509361891666;5091.7963281469065;5235.083860324428;5245.6852588844795;5257.86855328616;5265.55197320736;3892.6302001310396;3894.766314021168;3908.550516690617;3920.7059470539825;3927.8625248116177;3954.4661470701662;3971.4638523799495;3974.205158968218;3979.442877997025;3987.501562304712;4383.589026035667;4390.297552391602;4393.231184542692;4398.362237475612;4399.934000989988;4873.780679869415;4886;4957.950420495821;4965.255211718199;5007.39911210657;1334.126147373472;1349.2983648502723;1351.945922163122;1353.3098119958893;1355.3697530648296;880.5333173418098;930.274385978924;942.2556180617372;944.5843828715343;954.6754103604808;4213.536510983789;4288.048937733324;4332.4801023877335;4420.602145806893;4426.557344265548;5108.1943951756175;5108.795648174031;5126.461721519261;5128.3076784633595;5133.9743301284;4394.890127746832;4407.875991622116;4411.073674528385;4415.337699345059;4420.60750863477;2550.3241640965157;2585.7284985076294;2629.789616830649;2642.6168205610466;2651.7613414792763;4629.189891768927;4632.2356811126465;4696.201645720235;4712.363830882787;4735.479097299294;5110.054639891632;5118.411382690963;5135.229715542699;5140.665856719302;5156.767945442389;4441.311596702516;4612.5156858530045;4640.419947506562;4668.603168730628;4675.345451636774;4911.8211629209445;4930.654854160174;4959.222835212293;4965.201620760194;4968.950310496849;4819.807207711652;4850.49069847675;4855.174620314626;4880.31675565414;4892.461829198714;4534.161180181677;4818.7831547581145;4836.347093142381;4837.927431088607;4844.61243100544;3641.9817900910325;3646.596060516667;3647.3799454092336;3656.5063716397945;3681.8711345102793;5160.793568257228;5160.793568257228;5180.870478238075;5189.377274727057;5194.454582268807;4873.537013983666;4877.341558889504;4947.356843610308;4983.975080124576;4992.301077849177;4895.363602731622;4953.885375790418;4983.202687569971;4983.8504844854715;4991.950080499294;4906.239532872411;4917.26241063829;4918.868660208101;4920.6801557898625;4928.334674818853;4758.904821903612;4803.382410865097;4871.147549178809;5007.7496125192865;5010.87472813168;4783.928241076456;4786.234202527578;4800.639952003544;4856.373115006512;4859.4654587996 11:51:41 INFO - PROCESS | 30623 | |5;yui.html;612.0910447984742;643.8100760275718;665.7370338716207;669.3172963577151;694.9513534052616;12384;12929.48282068716;13396.665083372933;13409.061365704405;13928.79106813396;13080.607581772538;13088.541901033466;13346.93326533366;13386.66533336667;13398.263095529743;822.4695071678779;843.7721815109917;843.8481073406784;844.3456321350972;844.3920377328344;670.4334837062675;690.5269890125255;813.556611646654;836.9874451883227;844.4848642328175;876.7150676030284;878.1438097854573;879.0637970561331;879.5558243087264;879.7272845417909;872.7469033980138;872.7730789994583;873.3013589128672;876.0582373947999;876.1851478125341;515.51541550942;529.9814506492293;623.4949690750461;643.09002761093;648.2868844271264;14541.418343266256;14542.636434089232;14549.636259093608;14590.854091459056;14646.780298295535;13332.133411328232;13333.533326333532;13451.932740336333;13549.52576659822;13573.538747619294;12141.817872731915;12278.508859645603;12296.938515307456;12451.25292482454;13022.609321720363;4095;4127.504699436057;4154.099531708843;4170.603792639695;4347.7826108694435;58402;59079.40920590782;61862.38137618611;61953.99999999955;62785;10522.421266830244;10559.36643801359;10688.14494840411;10778.137748980063;10849.945750271198;20595.176192952415;20651;20716.896415517826;20877.164913403598;20936.47658808542;6274.403931626488;6343.777967771106;6423.197100362455;6450.0969864218105;6539.771108011292;3364.798112113281;3481.4777783332197;3497.038314463543;3497.8251087445524;3566.696830769362;2815.9859200704277;2843.8862445502364;2877.7553907918063;2900.0864727611156;2903.985480072586;483.4174819342684;484.75596155656996;486.7712175277614;492.94577596465075;496.34234639103335;563.2143160291453;569.7265312649952;572.2732130194629;572.4447286132445;583.9854003649858;8413.957930210432;8735.781605459788;8745.606447709868;8834.911650883409;8941;542.587633398612;559.2673597587174;578.6672663218666;578.9652620842763;585.5608293779666;4187.288161012635;4197.97901010493;4204.789760511962;4226.323788193874;4231.703780735319;53651;66250;67421.66289168522;67483.32516674869;68987;57655.13517297244;57711;58807.411925881046;59045.704771476725;59435.40564594385;53340.19989700158;54032.45967540353;55341;55754.16368754553;56091;7952.562609056326;8164.387670924586;8177.345812335118;8192.139825318256;8265.628046737791;36456.81771591125;37106.54721433445;38441;38677.6132238674;39484.802575986934;33692.32615347728;44369.55630443654;44930.32604511001;45021.77489112534;45451;10010.749731256778;10091.495425228855;10177.796444071226;10237.44609130993;10243.539040743333;10741.140708743125;11123.610673626385;11243;11430.44606376312;11500.94249528747;9656.662016829658;9993.850092248476;10190.082892539707;10194.89805101969;10547.945205479391;10459.738506537093;10976.615818446317;11345;11431.34197056967;11707.88292117068;11484.310941343547;11550;11776.646700598996;11988.220765650205;12381.62855114348;9859.30984831055;9866.556004979937;10166.390016599027;10537.063103427694;11127.387993660426;10036.447995360033;10249.436281004319;10272.33229840058;10280.691579252634;10311 11:51:41 INFO - PROCESS | 30623 | __end_tp_report 11:51:41 INFO - PROCESS | 30623 | __start_cc_report 11:51:41 INFO - PROCESS | 30623 | _x_x_mozilla_cycle_collect,1112 11:51:41 INFO - PROCESS | 30623 | __end_cc_report 11:51:41 INFO - PROCESS | 30623 | __startTimestamp1485719501536__endTimestamp 11:51:41 INFO - PROCESS | 30623 | 11:51:41 INFO - PROCESS | 30623 | ------- Summary: start ------- 11:51:41 INFO - PROCESS | 30623 | Number of tests: 6 11:51:41 INFO - PROCESS | 30623 | 11:51:41 INFO - PROCESS | 30623 | [#0] dojo.html Cycles:165 Average:4574.07 Median:4677.44 stddev:475.60 (10.2%) stddev-sans-first:449.32 11:51:41 INFO - PROCESS | 30623 | Values: 2533.7 2563.0 2568.1 2579.8 2601.1 4475.1 4511.7 4529.8 4601.4 4632.3 4538.9 4635.8 4658.0 4707.9 4740.4 4218.6 4224.2 4259.7 4308.0 4382.6 4038.7 4303.4 4357.1 4396.4 4438.3 4192.5 4277.2 4293.6 4338.2 4352.0 4180.3 4225.7 4239.9 4252.5 4296.4 4249.8 4249.8 4290.4 4291.5 4305.5 4599.4 4625.7 4631.7 4654.3 4686.4 4843.7 4903.0 4906.9 4952.7 4960.8 4962.2 4964.3 4979.3 5004.2 5023.2 4623.1 4662.0 4667.1 4668.2 4691.6 4945.1 4987.2 5071.3 5075.0 5128.5 4804.2 4833.4 4836.9 4860.7 4909.7 4864.8 4918.6 4923.8 4934.6 4935.2 4879.8 4893.8 4900.3 4910.7 5008.4 4940.2 4948.9 4960.2 4966.0 4984.8 4104.7 4152.2 4178.0 4217.0 4252.3 3659.0 3665.2 3691.7 3692.9 3701.1 4351.7 4352.2 4353.6 4358.7 4395.3 4808.9 4862.9 5044.7 5045.9 5096.8 4207.1 4236.4 4245.5 4248.9 4305.2 4411.8 4415.6 4425.1 4425.2 4457.2 4550.0 4621.5 4632.2 4641.5 4662.0 4879.4 4925.8 4964.3 4967.4 4988.3 4666.0 4670.6 4673.4 4675.9 4708.7 4878.4 4881.9 4893.3 4894.8 4943.0 4807.0 4844.5 4871.9 4896.5 4897.3 4782.9 4787.7 4798.0 4826.2 4831.1 4637.0 4671.9 4772.1 4783.7 4794.7 4677.4 4756.7 4800.6 4807.3 4851.2 4868.2 4892.8 4894.2 4898.5 4944.7 4762.9 4786.2 4790.1 4791.9 4844.3 11:51:41 INFO - PROCESS | 30623 | 11:51:41 INFO - PROCESS | 30623 | [#1] ext.html Cycles:180 Average:45120.38 Median:33125.50 stddev:76569.99 (231.2%) stddev-sans-first:76711.56 11:51:41 INFO - PROCESS | 30623 | Values: 517.7 523.9 531.6 552.0 563.5 29431.1 32643.8 32645.5 39044.0 41600.6 41406.4 41849.4 41921.6 41957.4 41979.4 7721.2 7896.7 7899.1 7902.4 7903.9 7515.4 7700.8 7800.3 10025.2 10318.1 10228.4 10262.9 10288.6 10290.6 10299.3 10151.1 10189.6 10191.6 10216.4 10227.4 10060.6 10118.5 10139.6 10154.0 10165.3 40176.8 40400.4 40442.4 40467.0 40479.0 3587.7 3671.2 3682.9 3696.4 3735.7 28413.1 28616.4 28646.6 28901.3 30217.7 3480.3 3513.2 3543.5 3573.6 3613.1 243254.0 243600.0 244086.0 244289.0 244670.0 55484.0 55594.7 55840.4 55932.4 55981.7 51488.2 51588.5 59193.4 59225.0 59284.0 15571.0 15844.3 15861.3 15864.5 15867.2 10411.6 11496.0 11559.2 11562.8 11578.1 15414.2 17240.7 17603.6 17646.5 18294.5 6547.4 6581.7 6607.0 6729.0 6852.4 719.2 772.7 774.6 776.9 781.5 26673.6 28133.3 28380.7 28445.3 28636.3 846.6 942.4 967.6 967.9 976.3 14339.6 14927.5 15100.2 15304.6 15532.6 327537.0 327765.0 329099.0 329368.0 329426.0 49516.8 49850.8 50774.0 50937.0 51307.2 1209.4 1233.3 1249.5 1250.4 1251.6 27447.0 28808.6 29012.3 29810.4 29813.4 44017.0 44682.0 44734.6 44747.8 44749.0 296979.0 298949.0 299005.0 299610.0 299881.0 23744.4 24512.5 24590.3 36955.3 37294.9 34077.8 35115.3 36113.6 36331.8 38563.2 32787.3 33749.0 33791.0 34045.3 34335.3 33139.7 33270.3 33351.3 33381.8 34097.3 32532.3 33111.3 33237.7 33488.7 33572.3 26727.0 29893.3 30056.7 30234.7 30391.8 22950.2 23422.6 23434.4 23441.2 23567.6 11:51:41 INFO - PROCESS | 30623 | 11:51:41 INFO - PROCESS | 30623 | [#2] jquery.html Cycles:180 Average:28737.84 Median:250084.43 stddev:83272.85 (33.3%) stddev-sans-first:83479.22 11:51:41 INFO - PROCESS | 30623 | Values: 376.0 386.3 398.5 400.8 412.4 13713.5 13913.0 16910.1 18571.4 18598.2 14387.3 14790.4 17447.4 17531.9 17673.5 4994.7 5166.6 5227.3 5267.8 5277.2 5216.7 5292.3 5296.7 5301.4 5301.8 5113.2 5190.7 5252.1 5253.8 5255.0 5115.3 5137.6 5138.4 5163.3 5166.9 4554.8 4721.9 4753.6 4755.6 4757.9 19626.5 19959.1 20114.7 21447.4 21761.8 1988.5 2035.7 2047.0 2051.0 2086.7 9207.1 9344.2 9784.2 10238.6 13416.9 1679.3 1703.1 1734.6 1761.3 1781.3 77698.2 79008.0 80564.6 81138.6 83820.6 10627.9 10868.8 10940.5 11085.2 11138.4 15099.8 15210.6 15249.4 15254.1 15254.7 6801.1 7129.0 7642.8 7818.2 8064.0 6862.3 6984.7 7133.3 7143.7 7596.9 8917.7 9095.0 9131.2 9248.6 9479.6 3348.1 3825.7 3894.0 3896.6 4002.2 923.5 955.2 956.1 958.5 965.1 16208.7 16216.4 16750.6 17358.9 17668.7 943.3 944.7 945.3 952.0 955.5 9748.2 9750.7 9762.6 9788.7 9808.9 495411.0 498384.0 503074.0 513059.0 516155.0 67759.0 92848.0 95884.0 96376.6 96780.0 925.2 943.9 956.7 961.4 962.4 14725.0 14867.6 14956.3 15094.5 15561.1 40174.0 40606.8 41621.8 41825.4 42784.8 54071.5 54560.5 56620.4 57515.7 59023.7 5714.7 7847.8 8126.5 8216.3 8287.7 11301.3 12026.6 12124.2 12168.0 12290.8 9925.0 10040.5 10327.6 10372.7 10385.8 10253.3 10585.7 10591.5 10781.8 10895.9 10551.8 10568.5 10618.6 10651.2 10976.9 7296.2 7337.8 7363.2 8189.5 8283.3 10141.3 10466.5 10582.8 11120.2 11422.1 11:51:41 INFO - PROCESS | 30623 | 11:51:41 INFO - PROCESS | 30623 | [#3] mootools.html Cycles:180 Average:4600.26 Median:4604.11 stddev:2465.16 (53.5%) stddev-sans-first:2459.49 11:51:41 INFO - PROCESS | 30623 | Values: 1286.4 1288.8 1289.3 1295.1 1301.7 6759.0 7141.0 7151.1 7159.1 7174.4 6296.9 6532.0 6730.4 6993.8 7026.7 2040.9 2104.8 2108.1 2110.3 2110.5 2099.9 2120.0 2125.8 2129.7 2134.6 1807.6 1861.8 1921.1 1977.7 2086.5 2036.0 2045.4 2047.2 2047.4 2049.9 1989.8 2023.7 2029.7 2034.7 2093.2 7014.3 7060.4 7061.9 7065.9 7072.9 4337.1 4460.6 4469.0 4471.1 4474.7 2681.3 2851.3 2895.5 2900.0 2904.8 1063.3 1099.2 1120.6 1170.7 1176.0 9141.6 9344.1 9353.4 9382.5 9384.8 3824.9 3982.5 3985.3 4049.8 4052.1 7961.2 7963.4 7963.6 7966.3 7978.0 4389.1 4391.6 4394.2 4394.5 4395.8 3657.5 3775.2 3962.1 4047.2 4142.0 3405.7 3411.1 3562.6 3563.3 3573.5 1165.6 1180.5 1196.9 1200.2 1201.9 787.4 792.1 799.8 806.6 810.9 4427.6 4432.8 4530.2 4624.9 4711.3 532.4 551.4 833.2 874.7 880.2 2967.9 3035.2 3082.6 3101.3 3103.0 8128.6 8303.0 8356.5 8392.1 8396.6 8195.7 8276.7 8293.4 8301.2 8313.9 6459.8 6467.9 6478.7 6566.7 6571.7 4499.8 4516.5 4595.2 4613.0 4737.3 7476.4 7483.2 7542.7 7656.5 7664.2 7630.0 7838.7 7840.1 7860.8 7868.4 5435.6 5580.7 5775.2 5937.9 5949.0 6411.3 6682.0 6687.9 6877.4 6887.1 6125.1 6206.7 6285.1 6329.7 6410.0 6091.1 6133.1 6152.4 6156.7 6162.2 5471.4 5586.4 5592.2 5592.6 5597.6 3815.0 3876.3 3923.3 3966.2 4031.0 3919.5 3974.8 4016.8 4032.2 4108.3 11:51:41 INFO - PROCESS | 30623 | 11:51:41 INFO - PROCESS | 30623 | [#4] prototype.html Cycles:180 Average:4171.08 Median:4685.77 stddev:1157.33 (24.7%) stddev-sans-first:1124.44 11:51:41 INFO - PROCESS | 30623 | Values: 347.9 355.1 359.6 360.2 363.3 4753.9 4819.3 4824.6 4842.4 4847.4 4709.4 4752.5 4763.0 4766.7 4770.5 3686.5 3775.3 3832.4 3833.3 3838.7 3844.9 3847.4 3882.6 3882.9 3894.6 3826.2 3827.7 3839.8 3869.2 3875.5 3695.2 3739.6 3785.8 3832.7 3845.6 3495.6 3499.5 3501.3 3504.3 3505.5 4647.0 4661.5 4661.9 4700.5 4707.1 4272.2 4417.6 4430.4 4434.4 4439.8 4980.0 4989.8 4995.2 4996.6 5029.7 3804.2 3807.5 3820.7 3827.9 3831.8 5091.8 5235.1 5245.7 5257.9 5265.6 3892.6 3894.8 3908.6 3920.7 3927.9 3954.5 3971.5 3974.2 3979.4 3987.5 4383.6 4390.3 4393.2 4398.4 4399.9 4873.8 4886.0 4958.0 4965.3 5007.4 1334.1 1349.3 1351.9 1353.3 1355.4 880.5 930.3 942.3 944.6 954.7 4213.5 4288.0 4332.5 4420.6 4426.6 5108.2 5108.8 5126.5 5128.3 5134.0 4394.9 4407.9 4411.1 4415.3 4420.6 2550.3 2585.7 2629.8 2642.6 2651.8 4629.2 4632.2 4696.2 4712.4 4735.5 5110.1 5118.4 5135.2 5140.7 5156.8 4441.3 4612.5 4640.4 4668.6 4675.3 4911.8 4930.7 4959.2 4965.2 4969.0 4819.8 4850.5 4855.2 4880.3 4892.5 4534.2 4818.8 4836.3 4837.9 4844.6 3642.0 3646.6 3647.4 3656.5 3681.9 5160.8 5160.8 5180.9 5189.4 5194.5 4873.5 4877.3 4947.4 4984.0 4992.3 4895.4 4953.9 4983.2 4983.9 4992.0 4906.2 4917.3 4918.9 4920.7 4928.3 4758.9 4803.4 4871.1 5007.7 5010.9 4783.9 4786.2 4800.6 4856.4 4859.5 11:51:41 INFO - PROCESS | 30623 | 11:51:41 INFO - PROCESS | 30623 | [#5] yui.html Cycles:180 Average:14928.35 Median:4289.74 stddev:18409.58 (429.2%) stddev-sans-first:18429.83 11:51:41 INFO - PROCESS | 30623 | Values: 612.1 643.8 665.7 669.3 695.0 12384.0 12929.5 13396.7 13409.1 13928.8 13080.6 13088.5 13346.9 13386.7 13398.3 822.5 843.8 843.8 844.3 844.4 670.4 690.5 813.6 837.0 844.5 876.7 878.1 879.1 879.6 879.7 872.7 872.8 873.3 876.1 876.2 515.5 530.0 623.5 643.1 648.3 14541.4 14542.6 14549.6 14590.9 14646.8 13332.1 13333.5 13451.9 13549.5 13573.5 12141.8 12278.5 12296.9 12451.3 13022.6 4095.0 4127.5 4154.1 4170.6 4347.8 58402.0 59079.4 61862.4 61954.0 62785.0 10522.4 10559.4 10688.1 10778.1 10849.9 20595.2 20651.0 20716.9 20877.2 20936.5 6274.4 6343.8 6423.2 6450.1 6539.8 3364.8 3481.5 3497.0 3497.8 3566.7 2816.0 2843.9 2877.8 2900.1 2904.0 483.4 484.8 486.8 492.9 496.3 563.2 569.7 572.3 572.4 584.0 8414.0 8735.8 8745.6 8834.9 8941.0 542.6 559.3 578.7 579.0 585.6 4187.3 4198.0 4204.8 4226.3 4231.7 53651.0 66250.0 67421.7 67483.3 68987.0 57655.1 57711.0 58807.4 59045.7 59435.4 53340.2 54032.5 55341.0 55754.2 56091.0 7952.6 8164.4 8177.3 8192.1 8265.6 36456.8 37106.5 38441.0 38677.6 39484.8 33692.3 44369.6 44930.3 45021.8 45451.0 10010.7 10091.5 10177.8 10237.4 10243.5 10741.1 11123.6 11243.0 11430.4 11500.9 9656.7 9993.9 10190.1 10194.9 10547.9 10459.7 10976.6 11345.0 11431.3 11707.9 11484.3 11550.0 11776.6 11988.2 12381.6 9859.3 9866.6 10166.4 10537.1 11127.4 10036.4 10249.4 10272.3 10280.7 10311.0 11:51:41 INFO - PROCESS | 30623 | -------- Summary: end -------- 11:51:41 INFO - PROCESS | 30623 | 11:51:42 INFO - TEST-INFO | 30623: exit 0 11:51:42 INFO - TEST-OK | dromaeo_css | took 1122079ms 11:51:42 INFO - TEST-START | kraken 11:51:42 INFO - operating with platform_type : linux_ 11:51:42 INFO - Initialising browser for kraken test... 11:51:42 INFO - TEST-INFO | started process 30922 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ei2vx/profile http://localhost:51064/getInfo.html) 11:51:46 INFO - PROCESS | 30922 | 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] 11:51:46 INFO - PROCESS | 30922 | __metrics Screen width/height:1600/1200 11:51:46 INFO - PROCESS | 30922 | colorDepth:24 11:51:46 INFO - PROCESS | 30922 | Browser inner width/height: 1024/697 11:51:46 INFO - PROCESS | 30922 | __metrics 11:51:47 INFO - PROCESS | 30922 | 1485719507496 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 11:51:47 INFO - PROCESS | 30922 | 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" 11:51:47 INFO - PROCESS | 30922 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:51:48 INFO - PROCESS | 30922 | console.error: PushService: 11:51:48 INFO - PROCESS | 30922 | stateChangeProcessEnqueue: Error transitioning state 11:51:48 INFO - PROCESS | 30922 | UnknownError 11:51:48 INFO - TEST-INFO | 30922: exit 0 11:51:48 INFO - Browser initialized. 11:51:48 INFO - Running cycle 1/1 for kraken test... 11:51:48 INFO - TEST-INFO | started process 31006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ei2vx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:01 INFO - PROCESS | 31006 | RSS: Main: 153841664 11:52:01 INFO - PROCESS | 31006 | 11:52:03 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51064/tests/kraken/driver.html?testName=audio-beat-detection) 11:52:04 INFO - PROCESS | 31006 | RSS: Main: 208556032 11:52:04 INFO - PROCESS | 31006 | 11:52:07 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51064/tests/kraken/driver.html?testName=audio-dft) 11:52:08 INFO - PROCESS | 31006 | RSS: Main: 187330560 11:52:08 INFO - PROCESS | 31006 | 11:52:11 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51064/tests/kraken/driver.html?testName=audio-fft) 11:52:11 INFO - PROCESS | 31006 | RSS: Main: 270151680 11:52:11 INFO - PROCESS | 31006 | 11:52:13 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51064/tests/kraken/driver.html?testName=audio-oscillator) 11:52:14 INFO - PROCESS | 31006 | RSS: Main: 181030912 11:52:14 INFO - PROCESS | 31006 | 11:52:16 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51064/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:52:17 INFO - PROCESS | 31006 | RSS: Main: 183861248 11:52:17 INFO - PROCESS | 31006 | 11:52:20 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51064/tests/kraken/driver.html?testName=imaging-darkroom) 11:52:21 INFO - PROCESS | 31006 | RSS: Main: 223457280 11:52:21 INFO - PROCESS | 31006 | 11:52:24 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51064/tests/kraken/driver.html?testName=imaging-desaturate) 11:52:25 INFO - PROCESS | 31006 | RSS: Main: 223162368 11:52:25 INFO - PROCESS | 31006 | 11:52:27 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51064/tests/kraken/driver.html?testName=json-parse-financial) 11:52:28 INFO - PROCESS | 31006 | RSS: Main: 221634560 11:52:28 INFO - PROCESS | 31006 | 11:52:30 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51064/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:52:30 INFO - PROCESS | 31006 | RSS: Main: 184119296 11:52:30 INFO - PROCESS | 31006 | 11:52:32 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51064/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:33 INFO - PROCESS | 31006 | RSS: Main: 191848448 11:52:33 INFO - PROCESS | 31006 | 11:52:35 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51064/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:36 INFO - PROCESS | 31006 | RSS: Main: 199528448 11:52:36 INFO - PROCESS | 31006 | 11:52:38 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:39 INFO - PROCESS | 31006 | RSS: Main: 205058048 11:52:39 INFO - PROCESS | 31006 | 11:52:42 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:43 INFO - PROCESS | 31006 | RSS: Main: 205672448 11:52:43 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | Cycle 1(1): loaded http://localhost:51064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51064/tests/kraken/driver.html?testName=ai-astar) 11:52:45 INFO - PROCESS | 31006 | RSS: Main: 256765952 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | __start_tp_report 11:52:45 INFO - PROCESS | 31006 | _x_x_mozilla_page_load 11:52:45 INFO - PROCESS | 31006 | _x_x_mozilla_page_load_details 11:52:45 INFO - PROCESS | 31006 | |i|pagename|runs| 11:52:45 INFO - PROCESS | 31006 | |0;ai-astar;113;116;115;118;118;115;116;117;117;117 11:52:45 INFO - PROCESS | 31006 | |1;audio-beat-detection;151;125;123;165;135;130;124;130;144;129 11:52:45 INFO - PROCESS | 31006 | |2;audio-dft;161;161;160;163;163;163;161;162;161;161 11:52:45 INFO - PROCESS | 31006 | |3;audio-fft;76;76;76;105;77;78;76;76;103;77 11:52:45 INFO - PROCESS | 31006 | |4;audio-oscillator;83;83;120;83;84;84;108;83;84;105 11:52:45 INFO - PROCESS | 31006 | |5;imaging-gaussian-blur;118;117;117;118;118;117;118;117;118;117 11:52:45 INFO - PROCESS | 31006 | |6;imaging-darkroom;150;148;148;151;150;149;149;150;148;149 11:52:45 INFO - PROCESS | 31006 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 11:52:45 INFO - PROCESS | 31006 | |8;json-parse-financial;60;59;60;60;60;61;60;62;61;61 11:52:45 INFO - PROCESS | 31006 | |9;json-stringify-tinderbox;67;68;72;68;67;71;68;68;68;68 11:52:45 INFO - PROCESS | 31006 | |10;stanford-crypto-aes;96;90;90;85;85;95;86;86;86;85 11:52:45 INFO - PROCESS | 31006 | |11;stanford-crypto-ccm;143;141;136;133;133;132;134;131;206;132 11:52:45 INFO - PROCESS | 31006 | |12;stanford-crypto-pbkdf2;175;176;181;176;175;176;178;174;175;176 11:52:45 INFO - PROCESS | 31006 | |13;stanford-crypto-sha256-iterative;69;67;67;67;70;75;66;67;67;65 11:52:45 INFO - PROCESS | 31006 | __end_tp_report 11:52:45 INFO - PROCESS | 31006 | __start_cc_report 11:52:45 INFO - PROCESS | 31006 | _x_x_mozilla_cycle_collect,1841 11:52:45 INFO - PROCESS | 31006 | __end_cc_report 11:52:45 INFO - PROCESS | 31006 | __startTimestamp1485719565338__endTimestamp 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | ------- Summary: start ------- 11:52:45 INFO - PROCESS | 31006 | Number of tests: 14 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#0] ai-astar Cycles:10 Average:116.20 Median:117.00 stddev:1.55 (1.3%) stddev-sans-first:1.13 11:52:45 INFO - PROCESS | 31006 | Values: 113.0 116.0 115.0 118.0 118.0 115.0 116.0 117.0 117.0 117.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:132.50 stddev:13.68 (10.3%) stddev-sans-first:13.33 11:52:45 INFO - PROCESS | 31006 | Values: 151.0 125.0 123.0 165.0 135.0 130.0 124.0 130.0 144.0 129.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 11:52:45 INFO - PROCESS | 31006 | Values: 161.0 161.0 160.0 163.0 163.0 163.0 161.0 162.0 161.0 161.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:11.62 (15.3%) stddev-sans-first:12.12 11:52:45 INFO - PROCESS | 31006 | Values: 76.0 76.0 76.0 105.0 77.0 78.0 76.0 76.0 103.0 77.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.00 stddev:13.84 (16.7%) stddev-sans-first:14.32 11:52:45 INFO - PROCESS | 31006 | Values: 83.0 83.0 120.0 83.0 84.0 84.0 108.0 83.0 84.0 105.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:52:45 INFO - PROCESS | 31006 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:1.03 (0.7%) stddev-sans-first:1.05 11:52:45 INFO - PROCESS | 31006 | Values: 150.0 148.0 148.0 151.0 150.0 149.0 149.0 150.0 148.0 149.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:52:45 INFO - PROCESS | 31006 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:60.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 11:52:45 INFO - PROCESS | 31006 | Values: 60.0 59.0 60.0 60.0 60.0 61.0 60.0 62.0 61.0 61.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.66 11:52:45 INFO - PROCESS | 31006 | Values: 67.0 68.0 72.0 68.0 67.0 71.0 68.0 68.0 68.0 68.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:88.00 stddev:4.20 (4.8%) stddev-sans-first:3.43 11:52:45 INFO - PROCESS | 31006 | Values: 96.0 90.0 90.0 85.0 85.0 95.0 86.0 86.0 86.0 85.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:135.00 stddev:22.81 (16.9%) stddev-sans-first:24.19 11:52:45 INFO - PROCESS | 31006 | Values: 143.0 141.0 136.0 133.0 133.0 132.0 134.0 131.0 206.0 132.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:176.00 stddev:1.99 (1.1%) stddev-sans-first:2.06 11:52:45 INFO - PROCESS | 31006 | Values: 175.0 176.0 181.0 176.0 175.0 176.0 178.0 174.0 175.0 176.0 11:52:45 INFO - PROCESS | 31006 | 11:52:45 INFO - PROCESS | 31006 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.00 stddev:2.83 (4.2%) stddev-sans-first:2.98 11:52:45 INFO - PROCESS | 31006 | Values: 69.0 67.0 67.0 67.0 70.0 75.0 66.0 67.0 67.0 65.0 11:52:45 INFO - PROCESS | 31006 | -------- Summary: end -------- 11:52:45 INFO - PROCESS | 31006 | 11:52:46 INFO - TEST-INFO | 31006: exit 0 11:52:46 INFO - TEST-OK | kraken | took 64131ms 11:52:46 INFO - SUITE-END | took 1186s 11:52:46 INFO - Completed test suite (00:19:46) 11:52:46 INFO - javascript benchmark 11:52:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6349.975654365879, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2533.7466253374664, 2563.0260501009607, 2568.1011645923927, 2579.8323108997924, 2601.0766178006807, 4475.104979004196, 4511.706739061967, 4529.841455549056, 4601.447826260849, 4632.305154226863, 4538.931916021263, 4635.814567417299, 4658.021815418766, 4707.858764237069, 4740.383750112489, 4218.578142185772, 4224.239636865363, 4259.723117997336, 4308.030693094044, 4382.583654552813, 4038.6970977176684, 4303.419038429804, 4357.12857428514, 4396.406485124515, 4438.289873620221, 4192.45498085247, 4277.1873344064525, 4293.613574778254, 4338.175746608134, 4351.9782401088105, 4180.28935081037, 4225.72532785371, 4239.894002649928, 4252.510961239435, 4296.4414626098405, 4249.808758605839, 4249.80875860587, 4290.377895205209, 4291.463567054118, 4305.526392096866, 4599.379083823675, 4625.722456652612, 4631.722096674211, 4654.278586819015, 4686.414198225222, 4843.685160464559, 4902.950970490285, 4906.852794416173, 4952.727599981999, 4960.801567937278, 4962.206047032458, 4964.304997300344, 4979.327790748239, 5004.249362595603, 5023.171176755831, 4623.0522742837975, 4662.0, 4667.089917466129, 4668.206404911173, 4691.577758001797, 4945.060438516671, 4987.226979818134, 5071.340725705709, 5074.974625126851, 5128.487151284841, 4804.159272127364, 4833.4441539222735, 4836.879078023077, 4860.659753817199, 4909.705417674951, 4864.805407783649, 4918.631102667314, 4923.75381230937, 4934.554843340322, 4935.185694360391, 4879.780409881564, 4893.828715994923, 4900.289458028566, 4910.729909854921, 5008.398992120896, 4940.209566469348, 4948.851534453972, 4960.181570040902, 4965.950340496621, 4984.77568509418, 4104.692148088905, 4152.1695660867945, 4178.039051018222, 4217.030083080847, 4252.340887162495, 3659.030356955409, 3665.1753355495334, 3691.667749902522, 3692.907677308035, 3701.0747313171705, 4351.673624478177, 4352.1513304905875, 4353.629941455012, 4358.65130789536, 4395.318725597537, 4808.879778005507, 4862.854114376574, 5044.697318160849, 5045.899082018339, 5096.821611243588, 4207.095474473003, 4236.449261596034, 4245.511766146871, 4248.87253382399, 4305.203537345601, 4411.7573533455325, 4415.55608440427, 4425.070735145656, 4425.203463376559, 4457.175422546839, 4549.977250113729, 4621.468531118964, 4632.189366860854, 4641.466231383434, 4662.044280922402, 4879.414470263591, 4925.753712314442, 4964.3298154748645, 4967.3542439482635, 4988.27669987857, 4665.976670116627, 4670.556297151765, 4673.392458980311, 4675.883102922454, 4708.741019243975, 4878.390201224847, 4881.926771098365, 4893.339399181065, 4894.849710318002, 4943.011397720542, 4807.0, 4844.539768721966, 4871.90256194867, 4896.461389247109, 4897.289892965571, 4782.904341913212, 4787.664863459524, 4797.952020479751, 4826.155422800925, 4831.106245344622, 4637.0, 4671.883202919954, 4772.069446457907, 4783.689060211075, 4794.712317260975, 4677.438707355139, 4756.667033307635, 4800.639952003684, 4807.254875494304, 4851.199552073868, 4868.245421959602, 4892.779824907817, 4894.216925291937, 4898.53463920927, 4944.678595891256, 4762.880927976689, 4786.186348320724, 4790.089882922233, 4791.856244312677, 4844.297576851407], "value": 4543.745885848226, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.6712787380013, 523.910935141026, 531.6464551073536, 551.9944800551993, 563.4534501533511, 29431.117066488012, 32643.83678081609, 32645.5103173452, 39044.0, 41600.58399416005, 41406.378904316385, 41849.37225941613, 41921.58078419215, 41957.370639440356, 41979.37030944531, 7721.227877212276, 7896.684132634717, 7899.091604465502, 7902.446828721992, 7903.881441778378, 7515.436342274324, 7700.845983080335, 7800.336971357441, 10025.197984161287, 10318.12295954841, 10228.43743594102, 10262.9486852566, 10288.588456461732, 10290.639827606035, 10299.27905046647, 10151.137153341975, 10189.643362482351, 10191.59233630654, 10216.387016779017, 10227.437490937959, 10060.597576096947, 10118.49407529628, 10139.64511242103, 10153.984601539862, 10165.322721750903, 40176.79911600453, 40400.39399409011, 40442.39336409956, 40467.0, 40479.0, 3587.6950459211, 3671.2473942841652, 3682.9447558286647, 3696.4085746280734, 3735.719821013408, 28413.147605571867, 28616.42767144666, 28646.570301445496, 28901.277468063257, 30217.697823021706, 3480.32133733922, 3513.2446523997464, 3543.450765131409, 3573.5711714594413, 3613.1147868772055, 243254.0, 243600.0, 244086.0, 244289.0, 244669.99999999822, 55484.0, 55594.72202638961, 55840.441595584336, 55932.44067559273, 55981.720091399286, 51488.22767658488, 51588.48411515912, 59193.40806591879, 59225.0, 59284.0, 15571.0, 15844.287007084478, 15861.286242119133, 15864.52406427809, 15867.206639668202, 10411.5835366586, 11496.0, 11559.190856639954, 11562.76874462506, 11578.073754099652, 15414.152221627694, 17240.65518689619, 17603.55991100233, 17646.470605881845, 18294.451166465027, 6547.410733034049, 6581.736730530725, 6607.0, 6728.966355168291, 6852.383285504328, 719.2447929673822, 772.6638912073266, 774.5585016540517, 776.8640487914705, 781.5115552779513, 26673.599896001575, 28133.296667583065, 28380.71619283822, 28445.288867778472, 28636.284092897844, 846.5809424334993, 942.4345392764286, 967.5549247346158, 967.9225661947028, 976.2873102635116, 14339.569812905422, 14927.477538286108, 15100.244987750568, 15304.617384565476, 15532.611684707746, 327537.0, 327765.0, 329099.0, 329368.0, 329426.0, 49516.75241623841, 49850.750746246034, 50774.0, 50937.0, 51307.23039154416, 1209.4315671634495, 1233.2970206982113, 1249.5439164704635, 1250.3685638752372, 1251.5932321995206, 27447.0, 28808.567871482363, 29012.27469313284, 29810.403791924473, 29813.403731925675, 44017.0, 44682.0, 44734.55265447304, 44747.77626111849, 44749.0, 296979.0, 298949.0, 299005.0, 299610.0, 299881.0, 23744.40638984039, 24512.50974980526, 24590.262292131265, 36955.260894781415, 37294.9487778164, 34077.82961085179, 35115.29769404547, 36113.63886361103, 36331.818340908125, 38563.2287354257, 32787.34425311528, 33749.0, 33791.0, 34045.319093617494, 34335.313293734485, 33139.66860331366, 33270.33459330751, 33351.33297334088, 33381.83309083439, 34097.31805363829, 32532.34935301328, 33111.33777324392, 33237.667623323454, 33488.66511334856, 33572.32855342928, 26727.0, 29893.252668683457, 30056.69943300539, 30234.697653023188, 30391.848040759654, 22950.19674311391, 23422.64866026977, 23434.414139646644, 23441.179558715365, 23567.646485303077], "value": 17732.700112740313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.98872033838995, 386.25067369303565, 398.5436675007117, 400.7935913004802, 412.35466494935423, 13713.493713493708, 13913.0, 16910.06994615296, 18571.442856714286, 18598.163082661296, 14387.280635968213, 14790.408383664668, 17447.389341373055, 17531.91234043828, 17673.469795906145, 4994.725290109042, 5166.638335316529, 5227.320448341729, 5267.815626453075, 5277.182036784286, 5216.7391630418515, 5292.285541451913, 5296.735163241822, 5301.416844147141, 5301.814436494724, 5113.181890897457, 5190.740462976836, 5252.054630166568, 5253.816116435925, 5255.02781985334, 5115.335006449175, 5137.61467889906, 5138.434772175039, 5163.277141200235, 5166.948330516684, 4554.795034223468, 4721.858344249678, 4753.643476739224, 4755.595774359183, 4757.857264282077, 19626.50933726654, 19959.101840417217, 20114.69827952582, 21447.35657930249, 21761.782382176134, 1988.532694816717, 2035.6539388304025, 2046.9590608187902, 2050.958980820375, 2086.739157605299, 9207.125323094362, 9344.159025687653, 9784.168345690625, 10238.641647542301, 13416.86583134166, 1679.2863033210836, 1703.0733048989587, 1734.6097128146193, 1761.339497688367, 1781.3052909365358, 77698.22301777023, 79008.0, 80564.59717701432, 81138.59430702809, 83820.58089709573, 10627.946860265803, 10868.836967445337, 10940.4529773511, 11085.22403431752, 11138.3873886937, 15099.849001509845, 15210.619734506727, 15249.3900243989, 15254.08475491474, 15254.694906101815, 6801.081853949752, 7129.0, 7642.770716878503, 7818.179091195457, 8063.959680201561, 6862.279460656659, 6984.720611175598, 7133.322334378226, 7143.678534465961, 7596.924030759732, 8917.687880924266, 9094.954525227464, 9131.178193962574, 9248.630054797733, 9479.620815167316, 3348.1294863335706, 3825.6748176405317, 3894.0, 3896.6298201670797, 4002.1795531915886, 923.4736200365727, 955.2024059909915, 956.1251454918811, 958.4728399380452, 965.0976337124671, 16208.675826483404, 16216.351345946267, 16750.581235468966, 17358.91320543389, 17668.734968975477, 943.3349488610513, 944.7165850245036, 945.3288165402504, 951.990480095204, 955.47926380123, 9748.2046723464, 9750.658726944523, 9762.560684769202, 9788.657396991213, 9808.852867206997, 495411.0, 498384.0, 503074.0, 513059.0, 516155.0, 67759.0, 92848.0, 95884.0, 96376.59058523593, 96780.0, 925.2043242811043, 943.8867335919596, 956.7225504603726, 961.3991255465335, 962.432165022626, 14725.0, 14867.628309291922, 14956.252187390804, 15094.54716358511, 15561.076852461742, 40174.0, 40606.79696601498, 41621.79189104035, 41825.37261941134, 42784.786076069424, 54071.45928540664, 54560.454395455534, 56620.43379566151, 57515.71242143762, 59023.704881475314, 5714.714264286852, 7847.84304313922, 8126.512409255227, 8216.274582337775, 8287.668493260202, 11301.26541774782, 12026.639200823989, 12124.211926224767, 12168.0, 12290.81563776562, 9925.0, 10040.548175331982, 10327.638532651621, 10372.74068148272, 10385.792284154426, 10253.333533320609, 10585.735356616146, 10591.4704264788, 10781.838272425763, 10895.891041089804, 10551.841722374016, 10568.481123792728, 10618.61081256711, 10651.201159912882, 10976.890231097586, 7296.160941491797, 7337.816554585965, 7363.226861179499, 8189.549574773445, 8283.337333013224, 10141.326681097536, 10466.529006194893, 10582.788344233226, 11120.221584489009, 11422.086233101165], "value": 8875.619983053626, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.398085360989, 1288.8324517812682, 1289.2715615677148, 1295.0999055656316, 1301.6550614087262, 6759.0, 7141.0, 7151.14186297645, 7159.069320988271, 7174.354308112269, 6296.8740625187465, 6531.967340163293, 6730.427913627347, 6993.755218567351, 7026.718931242757, 2040.8775473471603, 2104.8210902073342, 2108.1040557762967, 2110.3141479019305, 2110.48293168174, 2099.8737480850127, 2119.9788002120013, 2125.829933605308, 2129.7337832770904, 2134.573085382922, 1807.6203997160612, 1861.7858946221154, 1921.0874834453662, 1977.6539105656452, 2086.488810241485, 2036.0, 2045.3966080006285, 2047.2322878920404, 2047.3550831488033, 2049.92825251117, 1989.8408127349921, 2023.6559784836613, 2029.7056926745686, 2034.7049677796786, 2093.1941202637095, 7014.263502332284, 7060.435165186773, 7061.9293807062295, 7065.858682826366, 7072.929270707278, 4337.132573485315, 4460.620847227957, 4468.955310446887, 4471.128130014648, 4474.709143905636, 2681.2894582935537, 2851.3156842357685, 2895.4788138135127, 2900.0284904556997, 2904.7676185905075, 1063.3460421840512, 1099.2470157941755, 1120.6077872744556, 1170.7365842685413, 1175.9647210583696, 9141.634334626608, 9344.06559344067, 9353.438793672402, 9382.5308734563, 9384.812303753886, 3824.8661296854475, 3982.522097348337, 3985.2826491231276, 4049.8380064797666, 4052.1490486997473, 7961.243681850215, 7963.442559020813, 7963.641636126388, 7966.283034526805, 7978.042634883851, 4389.144116897174, 4391.626711729475, 4394.231009573312, 4394.538573449741, 4395.824167033346, 3657.487951686766, 3775.1505911170316, 3962.108525581779, 4047.2310261050307, 4141.97929010353, 3405.7105146062368, 3411.096059544223, 3562.5546806649168, 3563.3051554946537, 3573.4997100405963, 1165.5745652836654, 1180.4569897847086, 1196.9222000569935, 1200.2138599217526, 1201.9158658893969, 787.4094429178116, 792.0693185507006, 799.808046068951, 806.5523634382973, 810.9107998120202, 4427.557244275611, 4432.822687092545, 4530.161920044737, 4624.884377890512, 4711.340412342275, 532.3611666000814, 551.3631755322609, 833.1793183714037, 874.6632546469655, 880.1594477274188, 2967.9109626711233, 3035.210845180269, 3082.583851180062, 3101.3332133591384, 3103.0, 8128.552929588929, 8303.0, 8356.498610083292, 8392.076871544125, 8396.580170991427, 8195.71315003972, 8276.668933242603, 8293.377996650275, 8301.211384918422, 8313.916860831436, 6459.838504037437, 6467.902981455282, 6478.740850365933, 6566.737330506822, 6571.67141642916, 4499.797509112163, 4516.503184649751, 4595.218812801765, 4613.008203236186, 4737.265723812815, 7476.439267054884, 7483.176850546544, 7542.698292068256, 7656.506981138848, 7664.195259497673, 7630.0, 7838.725644602411, 7840.137584865774, 7860.84278314442, 7868.409869259943, 5435.592330575144, 5580.748866301107, 5775.249217601685, 5937.881242375215, 5949.0, 6411.262704789009, 6681.966590167018, 6687.933120668731, 6877.3810357068105, 6887.070245516791, 6125.111858780541, 6206.689665516797, 6285.088662143872, 6329.746810127727, 6410.038494225903, 6091.116788065794, 6133.141360209664, 6152.354002829638, 6156.6921653918025, 6162.168107305636, 5471.425500322568, 5586.38549759518, 5592.245046918614, 5592.636478628876, 5597.580181486323, 3814.9809250953567, 3876.2635099331037, 3923.313420151405, 3966.2265858157384, 4031.032552187395, 3919.5492518359615, 3974.7615143091507, 4016.779077150785, 4032.173404452139, 4108.281050816155], "value": 3777.5652977990367, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.90432631026465, 355.09450900204473, 359.5631307960827, 360.1644185489664, 363.2788914005698, 4753.857384278473, 4819.277108433736, 4824.565789078983, 4842.443119041312, 4847.369841920546, 4709.364235828162, 4752.500987396325, 4763.0, 4766.712987493374, 4770.451398089221, 3686.4654625079347, 3775.263823554408, 3832.405977073558, 3833.252515759428, 3838.692904567628, 3844.8654297099606, 3847.442120892469, 3882.611738826123, 3882.9029274268087, 3894.6300101490456, 3826.1582451860545, 3827.7320587558884, 3839.827207775643, 3869.2068126034237, 3875.4961854958815, 3695.150115473443, 3739.5699494558203, 3785.7539259948016, 3832.7317087803863, 3845.5962123977138, 3495.615482296945, 3499.5100685903994, 3501.3172431375892, 3504.316658251642, 3505.4917037029486, 4646.955339650577, 4661.510541393172, 4661.88345291367, 4700.4594471635855, 4707.129181101507, 4272.166927449149, 4417.624501917308, 4430.4240448741775, 4434.401355816988, 4439.844605438827, 4980.0, 4989.750512474362, 4995.200767877159, 4996.625253106032, 5029.748512574357, 3804.2201348723447, 3807.505024346845, 3820.726667632754, 3827.9234415311817, 3831.7509361891666, 5091.7963281469065, 5235.083860324428, 5245.6852588844795, 5257.86855328616, 5265.55197320736, 3892.6302001310396, 3894.766314021168, 3908.550516690617, 3920.7059470539825, 3927.8625248116177, 3954.4661470701662, 3971.4638523799495, 3974.205158968218, 3979.442877997025, 3987.501562304712, 4383.589026035667, 4390.297552391602, 4393.231184542692, 4398.362237475612, 4399.934000989988, 4873.780679869415, 4886.0, 4957.950420495821, 4965.255211718199, 5007.39911210657, 1334.126147373472, 1349.2983648502723, 1351.945922163122, 1353.3098119958893, 1355.3697530648296, 880.5333173418098, 930.274385978924, 942.2556180617372, 944.5843828715343, 954.6754103604808, 4213.536510983789, 4288.048937733324, 4332.4801023877335, 4420.602145806893, 4426.557344265548, 5108.1943951756175, 5108.795648174031, 5126.461721519261, 5128.3076784633595, 5133.9743301284, 4394.890127746832, 4407.875991622116, 4411.073674528385, 4415.337699345059, 4420.60750863477, 2550.3241640965157, 2585.7284985076294, 2629.789616830649, 2642.6168205610466, 2651.7613414792763, 4629.189891768927, 4632.2356811126465, 4696.201645720235, 4712.363830882787, 4735.479097299294, 5110.054639891632, 5118.411382690963, 5135.229715542699, 5140.665856719302, 5156.767945442389, 4441.311596702516, 4612.5156858530045, 4640.419947506562, 4668.603168730628, 4675.345451636774, 4911.8211629209445, 4930.654854160174, 4959.222835212293, 4965.201620760194, 4968.950310496849, 4819.807207711652, 4850.49069847675, 4855.174620314626, 4880.31675565414, 4892.461829198714, 4534.161180181677, 4818.7831547581145, 4836.347093142381, 4837.927431088607, 4844.61243100544, 3641.9817900910325, 3646.596060516667, 3647.3799454092336, 3656.5063716397945, 3681.8711345102793, 5160.793568257228, 5160.793568257228, 5180.870478238075, 5189.377274727057, 5194.454582268807, 4873.537013983666, 4877.341558889504, 4947.356843610308, 4983.975080124576, 4992.301077849177, 4895.363602731622, 4953.885375790418, 4983.202687569971, 4983.8504844854715, 4991.950080499294, 4906.239532872411, 4917.26241063829, 4918.868660208101, 4920.6801557898625, 4928.334674818853, 4758.904821903612, 4803.382410865097, 4871.147549178809, 5007.7496125192865, 5010.87472813168, 4783.928241076456, 4786.234202527578, 4800.639952003544, 4856.373115006512, 4859.4654587996], "value": 3823.0915004029557, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.0910447984742, 643.8100760275718, 665.7370338716207, 669.3172963577151, 694.9513534052616, 12384.0, 12929.48282068716, 13396.665083372933, 13409.061365704405, 13928.79106813396, 13080.607581772538, 13088.541901033466, 13346.93326533366, 13386.66533336667, 13398.263095529743, 822.4695071678779, 843.7721815109917, 843.8481073406784, 844.3456321350972, 844.3920377328344, 670.4334837062675, 690.5269890125255, 813.556611646654, 836.9874451883227, 844.4848642328175, 876.7150676030284, 878.1438097854573, 879.0637970561331, 879.5558243087264, 879.7272845417909, 872.7469033980138, 872.7730789994583, 873.3013589128672, 876.0582373947999, 876.1851478125341, 515.51541550942, 529.9814506492293, 623.4949690750461, 643.09002761093, 648.2868844271264, 14541.418343266256, 14542.636434089232, 14549.636259093608, 14590.854091459056, 14646.780298295535, 13332.133411328232, 13333.533326333532, 13451.932740336333, 13549.52576659822, 13573.538747619294, 12141.817872731915, 12278.508859645603, 12296.938515307456, 12451.25292482454, 13022.609321720363, 4095.0, 4127.504699436057, 4154.099531708843, 4170.603792639695, 4347.7826108694435, 58402.0, 59079.40920590782, 61862.38137618611, 61953.99999999955, 62785.0, 10522.421266830244, 10559.36643801359, 10688.14494840411, 10778.137748980063, 10849.945750271198, 20595.176192952415, 20651.0, 20716.896415517826, 20877.164913403598, 20936.47658808542, 6274.403931626488, 6343.777967771106, 6423.197100362455, 6450.0969864218105, 6539.771108011292, 3364.798112113281, 3481.4777783332197, 3497.038314463543, 3497.8251087445524, 3566.696830769362, 2815.9859200704277, 2843.8862445502364, 2877.7553907918063, 2900.0864727611156, 2903.985480072586, 483.4174819342684, 484.75596155656996, 486.7712175277614, 492.94577596465075, 496.34234639103335, 563.2143160291453, 569.7265312649952, 572.2732130194629, 572.4447286132445, 583.9854003649858, 8413.957930210432, 8735.781605459788, 8745.606447709868, 8834.911650883409, 8941.0, 542.587633398612, 559.2673597587174, 578.6672663218666, 578.9652620842763, 585.5608293779666, 4187.288161012635, 4197.97901010493, 4204.789760511962, 4226.323788193874, 4231.703780735319, 53651.0, 66250.0, 67421.66289168522, 67483.32516674869, 68987.0, 57655.13517297244, 57711.0, 58807.411925881046, 59045.704771476725, 59435.40564594385, 53340.19989700158, 54032.45967540353, 55341.0, 55754.16368754553, 56091.0, 7952.562609056326, 8164.387670924586, 8177.345812335118, 8192.139825318256, 8265.628046737791, 36456.81771591125, 37106.54721433445, 38441.0, 38677.6132238674, 39484.802575986934, 33692.32615347728, 44369.55630443654, 44930.32604511001, 45021.77489112534, 45451.0, 10010.749731256778, 10091.495425228855, 10177.796444071226, 10237.44609130993, 10243.539040743333, 10741.140708743125, 11123.610673626385, 11243.0, 11430.44606376312, 11500.94249528747, 9656.662016829658, 9993.850092248476, 10190.082892539707, 10194.89805101969, 10547.945205479391, 10459.738506537093, 10976.615818446317, 11345.0, 11431.34197056967, 11707.88292117068, 11484.310941343547, 11550.0, 11776.646700598996, 11988.220765650205, 12381.62855114348, 9859.30984831055, 9866.556004979937, 10166.390016599027, 10537.063103427694, 11127.387993660426, 10036.447995360033, 10249.436281004319, 10272.33229840058, 10280.691579252634, 10311.0], "value": 6346.911856331486, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 118.0, 118.0, 115.0, 116.0, 117.0, 117.0, 117.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 123.0, 165.0, 135.0, 130.0, 124.0, 130.0, 144.0, 129.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 163.0, 163.0, 163.0, 161.0, 162.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 105.0, 77.0, 78.0, 76.0, 76.0, 103.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 83.0, 84.0, 84.0, 108.0, 83.0, 84.0, 105.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 148.0, 151.0, 150.0, 149.0, 149.0, 150.0, 148.0, 149.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 60.0, 60.0, 61.0, 60.0, 62.0, 61.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 72.0, 68.0, 67.0, 71.0, 68.0, 68.0, 68.0, 68.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 90.0, 90.0, 85.0, 85.0, 95.0, 86.0, 86.0, 86.0, 85.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 136.0, 133.0, 133.0, 132.0, 134.0, 131.0, 206.0, 132.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 181.0, 176.0, 175.0, 176.0, 178.0, 174.0, 175.0, 176.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 70.0, 75.0, 66.0, 67.0, 67.0, 65.0], "value": 68.0, "unit": "score"}]}]} 11:52:47 INFO - Return code: 0 11:52:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:52:47 ERROR - # TBPL SUCCESS # 11:52:47 INFO - Running post-action listener: _resource_record_post_action 11:52:47 INFO - [mozharness: 2017-01-29 19:52:47.170651Z] Finished run-tests step (success) 11:52:47 INFO - Running post-run listener: _resource_record_post_run 11:52:47 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405725184; Read time: 12; Write time: 278592 11:52:47 INFO - TinderboxPrint: CPU usage
13.1% 11:52:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:52:47 INFO - TinderboxPrint: I/O write bytes / time
405,725,184 / 278,592 11:52:47 INFO - TinderboxPrint: CPU idle
8,352.6 (86.9%) 11:52:47 INFO - TinderboxPrint: CPU user
1,210.8 (12.6%) 11:52:47 INFO - TinderboxPrint: Swap in / out
0 / 0 11:52:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111820800; Read time: 0; Write time: 77776 11:52:47 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293904384; Read time: 12; Write time: 200816 11:52:47 INFO - Running post-run listener: _upload_blobber_files 11:52:47 INFO - Blob upload gear active. 11:52:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:52:47 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 11:52:47 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'] 11:52:47 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 11:52:48 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:49 INFO - (blobuploader) - INFO - Done attempting. 11:52:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:52:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:52 INFO - (blobuploader) - INFO - Done attempting. 11:52:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:52:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:52 INFO - (blobuploader) - INFO - Done attempting. 11:52:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:52:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:52:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:53 INFO - (blobuploader) - INFO - Done attempting. 11:52:53 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:53 INFO - Return code: 0 11:52:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88828b53fd14926febefd30bcfdc795a1fc29c33ca8dee1d5283e1c83c44269636a72179c569bc53c6284e7966cffd072b358529b5e8de15794f290c35b5134f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1e00e27efd6bc7a65fb3bf50d3a8d5ee1aac74024393efd6a3869461d42338ce20c75a496e081f3c0e517fc9ef7d108092ec0e1e01ab5903d5114e0e7eef672", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f24fca62bd9c6c1d5c3f66188df5421982d0d1efbae5f2775228a21e814b053516bc599a77c17df826eabca6c600c756ccd08eafbcd60695f97cd307bf0be343", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/060e011170157dfaea7a7ea63bbf4ac7adb99f9a57333e26d3114a811d0ab5ce45497d9b16d0f6550b2316993fa5f603d39fbf172d6586c525c3fee98ee5bb97"} 11:52:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:53 INFO - Contents: 11:52:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88828b53fd14926febefd30bcfdc795a1fc29c33ca8dee1d5283e1c83c44269636a72179c569bc53c6284e7966cffd072b358529b5e8de15794f290c35b5134f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1e00e27efd6bc7a65fb3bf50d3a8d5ee1aac74024393efd6a3869461d42338ce20c75a496e081f3c0e517fc9ef7d108092ec0e1e01ab5903d5114e0e7eef672", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f24fca62bd9c6c1d5c3f66188df5421982d0d1efbae5f2775228a21e814b053516bc599a77c17df826eabca6c600c756ccd08eafbcd60695f97cd307bf0be343", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/060e011170157dfaea7a7ea63bbf4ac7adb99f9a57333e26d3114a811d0ab5ce45497d9b16d0f6550b2316993fa5f603d39fbf172d6586c525c3fee98ee5bb97"} 11:52:53 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:53 INFO - Copying logs to upload dir... 11:52:53 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.189821 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-29 11:52:52.551901) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-29 11:52:52.555366) ========= 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=eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88828b53fd14926febefd30bcfdc795a1fc29c33ca8dee1d5283e1c83c44269636a72179c569bc53c6284e7966cffd072b358529b5e8de15794f290c35b5134f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1e00e27efd6bc7a65fb3bf50d3a8d5ee1aac74024393efd6a3869461d42338ce20c75a496e081f3c0e517fc9ef7d108092ec0e1e01ab5903d5114e0e7eef672", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f24fca62bd9c6c1d5c3f66188df5421982d0d1efbae5f2775228a21e814b053516bc599a77c17df826eabca6c600c756ccd08eafbcd60695f97cd307bf0be343", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/060e011170157dfaea7a7ea63bbf4ac7adb99f9a57333e26d3114a811d0ab5ce45497d9b16d0f6550b2316993fa5f603d39fbf172d6586c525c3fee98ee5bb97"} build_url:https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/HGkBkDAMQNCn5pyZaisZlA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88828b53fd14926febefd30bcfdc795a1fc29c33ca8dee1d5283e1c83c44269636a72179c569bc53c6284e7966cffd072b358529b5e8de15794f290c35b5134f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1e00e27efd6bc7a65fb3bf50d3a8d5ee1aac74024393efd6a3869461d42338ce20c75a496e081f3c0e517fc9ef7d108092ec0e1e01ab5903d5114e0e7eef672", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f24fca62bd9c6c1d5c3f66188df5421982d0d1efbae5f2775228a21e814b053516bc599a77c17df826eabca6c600c756ccd08eafbcd60695f97cd307bf0be343", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/060e011170157dfaea7a7ea63bbf4ac7adb99f9a57333e26d3114a811d0ab5ce45497d9b16d0f6550b2316993fa5f603d39fbf172d6586c525c3fee98ee5bb97"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-29 11:52:52.579664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 11:52:52.579955) ========= 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=eca2ab57546de7b41f256b19000001ef-1485716576.689689-607996461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 11:52:52.662728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-29 11:52:52.663079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-29 11:52:52.663356) ========= ========= Total master_lag: 0.18 =========