builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1485867610.02 results: success (0) revision: adab5d5d0372d1a26685d6fbc59cdfc977ad76c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:10.019006) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:10.019739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:10.020017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:10.052938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:10.053201) ========= 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=836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-31 05:00:10-- 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% 217M=0s 2017-01-31 05:00:10 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137167 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:10.203403) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:10.203720) ========= 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=836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018085 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:10.253132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:10.253472) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev adab5d5d0372d1a26685d6fbc59cdfc977ad76c6 --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 adab5d5d0372d1a26685d6fbc59cdfc977ad76c6 --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=836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-31 05:00:10,905 truncating revision to first 12 chars 2017-01-31 05:00:10,905 Setting DEBUG logging. 2017-01-31 05:00:10,905 attempt 1/10 2017-01-31 05:00:10,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/adab5d5d0372?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 05:00:11,429 unpacking tar archive at: mozilla-central-adab5d5d0372/testing/mozharness/ program finished with exit code 0 elapsedTime=0.847082 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:11.113405) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:11.113729) ========= script_repo_revision: adab5d5d0372d1a26685d6fbc59cdfc977ad76c6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:11.114111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:11.114375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 05:00:11.123663) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-31 05:00:11.124001) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:00:11 INFO - MultiFileLogger online at 20170131 05:00:11 in /builds/slave/test 05:00:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:00:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:00:11 INFO - {'append_to_log': False, 05:00:11 INFO - 'base_work_dir': '/builds/slave/test', 05:00:11 INFO - 'blob_upload_branch': 'Firefox', 05:00:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:00:11 INFO - 'branch': 'Firefox', 05:00:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:00:11 INFO - 'config_files': ('talos/linux_config.py',), 05:00:11 INFO - 'default_actions': ('clobber', 05:00:11 INFO - 'read-buildbot-config', 05:00:11 INFO - 'download-and-extract', 05:00:11 INFO - 'populate-webroot', 05:00:11 INFO - 'create-virtualenv', 05:00:11 INFO - 'install', 05:00:11 INFO - 'run-tests'), 05:00:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:00:11 INFO - 'download_minidump_stackwalk': True, 05:00:11 INFO - 'download_symbols': 'ondemand', 05:00:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:00:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:00:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:00:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:00:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:00:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:00:11 INFO - 'installer_path': 'installer.exe', 05:00:11 INFO - 'log_level': 'info', 05:00:11 INFO - 'log_name': 'talos', 05:00:11 INFO - 'log_to_console': True, 05:00:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:00:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:00:11 INFO - 'opt_config_files': (), 05:00:11 INFO - 'pip_index': False, 05:00:11 INFO - 'sps_profile': False, 05:00:11 INFO - 'sps_profile_interval': 0, 05:00:11 INFO - 'suite': 'dromaeojs', 05:00:11 INFO - 'system_bits': '32', 05:00:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:00:11 INFO - 'title': 'talos-linux64-ix-028', 05:00:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:00:11 INFO - 'use_talos_json': True, 05:00:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:00:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:00:11 INFO - 'work_dir': 'build'} 05:00:11 INFO - [mozharness: 2017-01-31 13:00:11.884473Z] Running clobber step. 05:00:11 INFO - Running pre-action listener: _resource_record_pre_action 05:00:11 INFO - Running main action method: clobber 05:00:11 INFO - rmtree: /builds/slave/test/build 05:00:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:00:12 INFO - Running post-action listener: _resource_record_post_action 05:00:12 INFO - [mozharness: 2017-01-31 13:00:12.356406Z] Finished clobber step (success) 05:00:12 INFO - [mozharness: 2017-01-31 13:00:12.356509Z] Running read-buildbot-config step. 05:00:12 INFO - Running pre-action listener: _resource_record_pre_action 05:00:12 INFO - Running main action method: read_buildbot_config 05:00:12 INFO - Using buildbot properties: 05:00:12 INFO - { 05:00:12 INFO - "project": "", 05:00:12 INFO - "product": "firefox", 05:00:12 INFO - "who": "archaeopteryx@coole-files.de", 05:00:12 INFO - "installer_path": "public/build/target.tar.bz2", 05:00:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:00:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:00:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:00:12 INFO - "stage_platform": "linux64-pgo", 05:00:12 INFO - "basedir": "/builds/slave/test", 05:00:12 INFO - "buildnumber": 12, 05:00:12 INFO - "platform": "ubuntu64_hw", 05:00:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:00:12 INFO - "slavebuilddir": "test", 05:00:12 INFO - "taskId": "AlWpPs81QgiOvkrww8GuCg", 05:00:12 INFO - "branch": "mozilla-central", 05:00:12 INFO - "script_repo_revision": "production", 05:00:12 INFO - "revision": "adab5d5d0372d1a26685d6fbc59cdfc977ad76c6", 05:00:12 INFO - "slavename": "talos-linux64-ix-028", 05:00:12 INFO - "repo_path": "mozilla-central" 05:00:12 INFO - } 05:00:12 INFO - Finding installer, test and symbols from parent task. 05:00:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AlWpPs81QgiOvkrww8GuCg'}, attempt #1 05:00:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AlWpPs81QgiOvkrww8GuCg'}, attempt #1 05:00:13 INFO - Task dependencies: Fd1wDynYTdS4hgZvPX30iQ 05:00:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ'}, attempt #1 05:00:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.tar.bz2 05:00:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/test_packages.json 05:00:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.crashreporter-symbols.zip 05:00:13 INFO - Running post-action listener: _resource_record_post_action 05:00:13 INFO - [mozharness: 2017-01-31 13:00:13.747655Z] Finished read-buildbot-config step (success) 05:00:13 INFO - [mozharness: 2017-01-31 13:00:13.747874Z] Running download-and-extract step. 05:00:13 INFO - Running pre-action listener: _resource_record_pre_action 05:00:13 INFO - Running main action method: download_and_extract 05:00:13 INFO - mkdir: /builds/slave/test/build/tests 05:00:13 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')]} 05:00:13 INFO - trying https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.test_packages.json 05:00:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:00:14 INFO - Downloaded 896 bytes. 05:00:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:00:14 INFO - Using the following test package requirements: 05:00:14 INFO - {u'common': [u'target.common.tests.zip'], 05:00:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:00:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:00:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:00:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:00:14 INFO - u'mozbase': [u'target.common.tests.zip'], 05:00:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:00:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:00:14 INFO - u'web-platform': [u'target.common.tests.zip', 05:00:14 INFO - u'target.web-platform.tests.zip'], 05:00:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:00:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:00:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.common.tests.zip 05:00:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:00:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.common.tests.zip into memory 05:00:17 INFO - Expected file size: 21893038 05:00:17 INFO - Obtained file size: 21893038 05:00:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:00:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.common.tests.zip 05:00:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:00:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.common.tests.zip into memory 05:00:22 INFO - Expected file size: 21893038 05:00:22 INFO - Obtained file size: 21893038 05:00:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.talos.tests.zip 05:00:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:00:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.talos.tests.zip into memory 05:00:28 INFO - Expected file size: 14403454 05:00:28 INFO - Obtained file size: 14403454 05:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:29 INFO - trying https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.tar.bz2 05:00:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:00:31 INFO - Downloaded 61600388 bytes. 05:00:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.tar.bz2 05:00:31 INFO - mkdir: /builds/slave/test/properties 05:00:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:00:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:00:31 INFO - Contents: 05:00:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.tar.bz2 05:00:31 INFO - Running post-action listener: _resource_record_post_action 05:00:31 INFO - Running post-action listener: set_extra_try_arguments 05:00:31 INFO - [mozharness: 2017-01-31 13:00:31.060717Z] Finished download-and-extract step (success) 05:00:31 INFO - [mozharness: 2017-01-31 13:00:31.060813Z] Running populate-webroot step. 05:00:31 INFO - Running pre-action listener: _resource_record_pre_action 05:00:31 INFO - Running main action method: populate_webroot 05:00:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:00:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:00:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:00:31 INFO - '--tppagecycles', 05:00:31 INFO - '7'], 05:00:31 INFO - 'tests': ['tsvgm']}}, 05:00:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:00:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:00:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:00:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:00:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:00:31 INFO - 'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:00:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:00:31 INFO - 'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['damp', 'tps']}, 05:00:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:00:31 INFO - 'tests': ['damp', 'tps']}, 05:00:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['dromaeo_dom']}, 05:00:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:00:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['basic_compositor_video']}, 05:00:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:00:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['a11yr', 05:00:31 INFO - 'ts_paint', 05:00:31 INFO - 'tpaint', 05:00:31 INFO - 'sessionrestore', 05:00:31 INFO - 'sessionrestore_no_auto_restore', 05:00:31 INFO - 'tabpaint']}, 05:00:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:00:31 INFO - 'ts_paint', 05:00:31 INFO - 'tpaint', 05:00:31 INFO - 'sessionrestore', 05:00:31 INFO - 'sessionrestore_no_auto_restore', 05:00:31 INFO - 'tabpaint']}, 05:00:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:00:31 INFO - 'ts_paint', 05:00:31 INFO - 'tpaint', 05:00:31 INFO - 'sessionrestore', 05:00:31 INFO - 'sessionrestore_no_auto_restore', 05:00:31 INFO - 'tabpaint']}, 05:00:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:00:31 INFO - 'ts_paint', 05:00:31 INFO - 'tpaint', 05:00:31 INFO - 'sessionrestore', 05:00:31 INFO - 'sessionrestore_no_auto_restore', 05:00:31 INFO - 'tabpaint']}, 05:00:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['a11yr', 05:00:31 INFO - 'ts_paint', 05:00:31 INFO - 'tpaint', 05:00:31 INFO - 'sessionrestore', 05:00:31 INFO - 'sessionrestore_no_auto_restore', 05:00:31 INFO - 'tabpaint']}, 05:00:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['a11yr', 05:00:31 INFO - 'ts_paint', 05:00:31 INFO - 'tpaint', 05:00:31 INFO - 'sessionrestore', 05:00:31 INFO - 'sessionrestore_no_auto_restore', 05:00:31 INFO - 'tabpaint']}, 05:00:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['tsvgx', 05:00:31 INFO - 'tsvgr_opacity', 05:00:31 INFO - 'tart', 05:00:31 INFO - 'tscrollx', 05:00:31 INFO - 'cart', 05:00:31 INFO - 'tsvg_static']}, 05:00:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:00:31 INFO - 'tsvgr_opacity', 05:00:31 INFO - 'tart', 05:00:31 INFO - 'tscrollx', 05:00:31 INFO - 'cart', 05:00:31 INFO - 'tsvg_static']}, 05:00:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:00:31 INFO - 'talos_options': ['--disable-e10s'], 05:00:31 INFO - 'tests': ['tp5o']}, 05:00:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:00:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:00:31 INFO - 'talos_options': ['--disable-e10s', 05:00:31 INFO - '--xperf_path', 05:00:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:31 INFO - 'tests': ['tp5n']}, 05:00:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:00:31 INFO - 'talos_options': ['--xperf_path', 05:00:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:31 INFO - 'tests': ['tp5n']}}, 05:00:31 INFO - 'talos.zip': {'path': '', 05:00:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:00:31 INFO - Running post-action listener: _resource_record_post_action 05:00:31 INFO - [mozharness: 2017-01-31 13:00:31.074095Z] Finished populate-webroot step (success) 05:00:31 INFO - [mozharness: 2017-01-31 13:00:31.074189Z] Running create-virtualenv step. 05:00:31 INFO - Running pre-action listener: _resource_record_pre_action 05:00:31 INFO - Running main action method: create_virtualenv 05:00:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:00:31 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 05:00:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:00:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:00:31 INFO - Using real prefix '/usr' 05:00:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:00:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:33 INFO - Installing pip.................done. 05:00:33 INFO - Return code: 0 05:00:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:00:33 INFO - Reading from file tmpfile_stdout 05:00:33 INFO - Output received: 05:00:33 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) 05:00:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:00:33 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')]} 05:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:33 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')]} 05:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:33 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 0x221e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, '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': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', '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 05:00:33 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 05:00:33 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 05:00:33 INFO - Using env: {'DISPLAY': ':0', 05:00:33 INFO - 'HOME': '/home/cltbld', 05:00:33 INFO - 'LANG': 'en_US.UTF-8', 05:00:33 INFO - 'LANGUAGE': 'en_US:en', 05:00:33 INFO - 'LOGNAME': 'cltbld', 05:00:33 INFO - 'MAIL': '/var/mail/cltbld', 05:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:33 INFO - 'MOZ_NO_REMOTE': '1', 05:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:33 INFO - 'NO_EM_RESTART': '1', 05:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:33 INFO - 'PWD': '/builds/slave/test', 05:00:33 INFO - 'SHELL': '/bin/bash', 05:00:33 INFO - 'SHLVL': '1', 05:00:33 INFO - 'TERM': 'linux', 05:00:33 INFO - 'TMOUT': '86400', 05:00:33 INFO - 'USER': 'cltbld', 05:00:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:33 INFO - '_': '/tools/buildbot/bin/python'} 05:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:34 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 05:00:34 INFO - Cleaning up... 05:00:34 INFO - Return code: 0 05:00:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x221e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, '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': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', '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 05:00:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:00:34 INFO - Using env: {'DISPLAY': ':0', 05:00:34 INFO - 'HOME': '/home/cltbld', 05:00:34 INFO - 'LANG': 'en_US.UTF-8', 05:00:34 INFO - 'LANGUAGE': 'en_US:en', 05:00:34 INFO - 'LOGNAME': 'cltbld', 05:00:34 INFO - 'MAIL': '/var/mail/cltbld', 05:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:34 INFO - 'MOZ_NO_REMOTE': '1', 05:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:34 INFO - 'NO_EM_RESTART': '1', 05:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:34 INFO - 'PWD': '/builds/slave/test', 05:00:34 INFO - 'SHELL': '/bin/bash', 05:00:34 INFO - 'SHLVL': '1', 05:00:34 INFO - 'TERM': 'linux', 05:00:34 INFO - 'TMOUT': '86400', 05:00:34 INFO - 'USER': 'cltbld', 05:00:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:34 INFO - '_': '/tools/buildbot/bin/python'} 05:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:34 INFO - Downloading/unpacking psutil>=3.1.1 05:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:36 INFO - Installing collected packages: psutil 05:00:36 INFO - Running setup.py install for psutil 05:00:36 INFO - building 'psutil._psutil_linux' extension 05:00:36 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 05:00:36 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 05:00:36 INFO - building 'psutil._psutil_posix' extension 05:00:36 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 05:00:36 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 05:00:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:36 INFO - Successfully installed psutil 05:00:36 INFO - Cleaning up... 05:00:37 INFO - Return code: 0 05:00:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:00:37 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')]} 05:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:37 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')]} 05:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:37 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 0x221e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, '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': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', '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 05:00:37 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 05:00:37 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 05:00:37 INFO - Using env: {'DISPLAY': ':0', 05:00:37 INFO - 'HOME': '/home/cltbld', 05:00:37 INFO - 'LANG': 'en_US.UTF-8', 05:00:37 INFO - 'LANGUAGE': 'en_US:en', 05:00:37 INFO - 'LOGNAME': 'cltbld', 05:00:37 INFO - 'MAIL': '/var/mail/cltbld', 05:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:37 INFO - 'MOZ_NO_REMOTE': '1', 05:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:37 INFO - 'NO_EM_RESTART': '1', 05:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:37 INFO - 'PWD': '/builds/slave/test', 05:00:37 INFO - 'SHELL': '/bin/bash', 05:00:37 INFO - 'SHLVL': '1', 05:00:37 INFO - 'TERM': 'linux', 05:00:37 INFO - 'TMOUT': '86400', 05:00:37 INFO - 'USER': 'cltbld', 05:00:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:37 INFO - '_': '/tools/buildbot/bin/python'} 05:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:00:39 INFO - Installing collected packages: mozsystemmonitor 05:00:39 INFO - Running setup.py install for mozsystemmonitor 05:00:39 INFO - Successfully installed mozsystemmonitor 05:00:39 INFO - Cleaning up... 05:00:39 INFO - Return code: 0 05:00:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x221e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, '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': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', '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 05:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:00:39 INFO - Using env: {'DISPLAY': ':0', 05:00:39 INFO - 'HOME': '/home/cltbld', 05:00:39 INFO - 'LANG': 'en_US.UTF-8', 05:00:39 INFO - 'LANGUAGE': 'en_US:en', 05:00:39 INFO - 'LOGNAME': 'cltbld', 05:00:39 INFO - 'MAIL': '/var/mail/cltbld', 05:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:39 INFO - 'MOZ_NO_REMOTE': '1', 05:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:39 INFO - 'NO_EM_RESTART': '1', 05:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:39 INFO - 'PWD': '/builds/slave/test', 05:00:39 INFO - 'SHELL': '/bin/bash', 05:00:39 INFO - 'SHLVL': '1', 05:00:39 INFO - 'TERM': 'linux', 05:00:39 INFO - 'TMOUT': '86400', 05:00:39 INFO - 'USER': 'cltbld', 05:00:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:39 INFO - '_': '/tools/buildbot/bin/python'} 05:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:39 INFO - Downloading/unpacking jsonschema==2.5.1 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:41 INFO - warning: no files found matching '*.txt' 05:00:41 INFO - no previously-included directories found matching 'build' 05:00:41 INFO - no previously-included directories found matching 'dist' 05:00:41 INFO - no previously-included directories found matching '.git*' 05:00:41 INFO - Installing collected packages: jsonschema, functools32 05:00:42 INFO - Running setup.py install for functools32 05:00:42 INFO - warning: no files found matching '*.txt' 05:00:42 INFO - no previously-included directories found matching 'build' 05:00:42 INFO - no previously-included directories found matching 'dist' 05:00:42 INFO - no previously-included directories found matching '.git*' 05:00:42 INFO - Successfully installed jsonschema functools32 05:00:42 INFO - Cleaning up... 05:00:42 INFO - Return code: 0 05:00:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:00: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')]} 05:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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', '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 0x221e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, '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': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', '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 05:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:00: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 functools32==3.2.3-2 05:00:42 INFO - Using env: {'DISPLAY': ':0', 05:00:42 INFO - 'HOME': '/home/cltbld', 05:00:42 INFO - 'LANG': 'en_US.UTF-8', 05:00:42 INFO - 'LANGUAGE': 'en_US:en', 05:00:42 INFO - 'LOGNAME': 'cltbld', 05:00:42 INFO - 'MAIL': '/var/mail/cltbld', 05:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:42 INFO - 'MOZ_NO_REMOTE': '1', 05:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:42 INFO - 'NO_EM_RESTART': '1', 05:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:42 INFO - 'PWD': '/builds/slave/test', 05:00:42 INFO - 'SHELL': '/bin/bash', 05:00:42 INFO - 'SHLVL': '1', 05:00:42 INFO - 'TERM': 'linux', 05:00:42 INFO - 'TMOUT': '86400', 05:00:42 INFO - 'USER': 'cltbld', 05:00:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:42 INFO - '_': '/tools/buildbot/bin/python'} 05:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:00:42 INFO - Cleaning up... 05:00:42 INFO - Return code: 0 05:00:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:00: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')]} 05:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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', '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 0x221e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, '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': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', '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 05:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:00: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 blobuploader==1.2.4 05:00:42 INFO - Using env: {'DISPLAY': ':0', 05:00:42 INFO - 'HOME': '/home/cltbld', 05:00:42 INFO - 'LANG': 'en_US.UTF-8', 05:00:42 INFO - 'LANGUAGE': 'en_US:en', 05:00:42 INFO - 'LOGNAME': 'cltbld', 05:00:42 INFO - 'MAIL': '/var/mail/cltbld', 05:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:42 INFO - 'MOZ_NO_REMOTE': '1', 05:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:42 INFO - 'NO_EM_RESTART': '1', 05:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:42 INFO - 'PWD': '/builds/slave/test', 05:00:42 INFO - 'SHELL': '/bin/bash', 05:00:42 INFO - 'SHLVL': '1', 05:00:42 INFO - 'TERM': 'linux', 05:00:42 INFO - 'TMOUT': '86400', 05:00:42 INFO - 'USER': 'cltbld', 05:00:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:42 INFO - '_': '/tools/buildbot/bin/python'} 05:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:00:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:00:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:00:45 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 05:00:45 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 05:00:45 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 05:00:45 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 05:00:45 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 05:00:45 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 05:00:45 INFO - Downloading docopt-0.6.1.tar.gz 05:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:00:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:00:45 INFO - Running setup.py install for blobuploader 05:00:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:00:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:00:45 INFO - Running setup.py install for requests 05:00:45 INFO - Running setup.py install for docopt 05:00:45 INFO - Successfully installed blobuploader requests docopt 05:00:45 INFO - Cleaning up... 05:00:46 INFO - Return code: 0 05:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:46 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 0x221e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, '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': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', '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 05:00:46 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 05:00:46 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 05:00:46 INFO - Using env: {'DISPLAY': ':0', 05:00:46 INFO - 'HOME': '/home/cltbld', 05:00:46 INFO - 'LANG': 'en_US.UTF-8', 05:00:46 INFO - 'LANGUAGE': 'en_US:en', 05:00:46 INFO - 'LOGNAME': 'cltbld', 05:00:46 INFO - 'MAIL': '/var/mail/cltbld', 05:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:46 INFO - 'MOZ_NO_REMOTE': '1', 05:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:46 INFO - 'NO_EM_RESTART': '1', 05:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:46 INFO - 'PWD': '/builds/slave/test', 05:00:46 INFO - 'SHELL': '/bin/bash', 05:00:46 INFO - 'SHLVL': '1', 05:00:46 INFO - 'TERM': 'linux', 05:00:46 INFO - 'TMOUT': '86400', 05:00:46 INFO - 'USER': 'cltbld', 05:00:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:46 INFO - '_': '/tools/buildbot/bin/python'} 05:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:00:46 INFO - Running setup.py (path:/tmp/pip-qdMzZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:00:46 INFO - Running setup.py (path:/tmp/pip-7YsqnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:00:46 INFO - Running setup.py (path:/tmp/pip-QjST6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:00:46 INFO - Running setup.py (path:/tmp/pip-ahRJC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:00:46 INFO - Running setup.py (path:/tmp/pip-rVHr3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:00:46 INFO - Running setup.py (path:/tmp/pip-oxcA_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:00:46 INFO - Running setup.py (path:/tmp/pip-4hgTWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:00:46 INFO - Running setup.py (path:/tmp/pip-8N8GNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:00:46 INFO - Running setup.py (path:/tmp/pip-XPHxKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:00:46 INFO - Running setup.py (path:/tmp/pip-zRDs2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:00:46 INFO - Running setup.py (path:/tmp/pip-urE1a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:00:47 INFO - Running setup.py (path:/tmp/pip-BsZVuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:00:47 INFO - Running setup.py (path:/tmp/pip-pXl4MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:00:47 INFO - Running setup.py (path:/tmp/pip-_ZrMNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:47 INFO - Running setup.py (path:/tmp/pip-rXwiaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:00:47 INFO - Running setup.py (path:/tmp/pip-NkKuK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:00:47 INFO - Running setup.py (path:/tmp/pip-U7M4V1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:00:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:00:47 INFO - Running setup.py install for manifestparser 05:00:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:00:47 INFO - Running setup.py install for mozcrash 05:00:47 INFO - Running setup.py install for mozdebug 05:00:47 INFO - Running setup.py install for mozdevice 05:00:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:00:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:00:47 INFO - Running setup.py install for mozfile 05:00:48 INFO - Running setup.py install for mozhttpd 05:00:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Running setup.py install for mozinfo 05:00:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Running setup.py install for mozInstall 05:00:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Running setup.py install for mozleak 05:00:48 INFO - Running setup.py install for mozlog 05:00:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Running setup.py install for moznetwork 05:00:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Running setup.py install for mozprocess 05:00:48 INFO - Running setup.py install for mozprofile 05:00:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Running setup.py install for mozrunner 05:00:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:00:48 INFO - Running setup.py install for mozscreenshot 05:00:49 INFO - Running setup.py install for moztest 05:00:49 INFO - Running setup.py install for mozversion 05:00:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:00:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:00:49 INFO - Cleaning up... 05:00:49 INFO - Return code: 0 05:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:49 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 0x221e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, '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': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', '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 05:00:49 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 05:00:49 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 05:00:49 INFO - Using env: {'DISPLAY': ':0', 05:00:49 INFO - 'HOME': '/home/cltbld', 05:00:49 INFO - 'LANG': 'en_US.UTF-8', 05:00:49 INFO - 'LANGUAGE': 'en_US:en', 05:00:49 INFO - 'LOGNAME': 'cltbld', 05:00:49 INFO - 'MAIL': '/var/mail/cltbld', 05:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:49 INFO - 'MOZ_NO_REMOTE': '1', 05:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:49 INFO - 'NO_EM_RESTART': '1', 05:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:49 INFO - 'PWD': '/builds/slave/test', 05:00:49 INFO - 'SHELL': '/bin/bash', 05:00:49 INFO - 'SHLVL': '1', 05:00:49 INFO - 'TERM': 'linux', 05:00:49 INFO - 'TMOUT': '86400', 05:00:49 INFO - 'USER': 'cltbld', 05:00:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:49 INFO - '_': '/tools/buildbot/bin/python'} 05:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:00:49 INFO - Running setup.py (path:/tmp/pip-1_Cn0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:00:49 INFO - Running setup.py (path:/tmp/pip-6WxhOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:00:49 INFO - Running setup.py (path:/tmp/pip-PiA5sX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:00:49 INFO - Running setup.py (path:/tmp/pip-kR9fyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:00:49 INFO - Running setup.py (path:/tmp/pip-8BRcGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:00:49 INFO - Running setup.py (path:/tmp/pip-73OcU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:00:49 INFO - Running setup.py (path:/tmp/pip-uzADh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:00:49 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)) 05:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:00:50 INFO - Running setup.py (path:/tmp/pip-fKL3Lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:00:50 INFO - Running setup.py (path:/tmp/pip-M41RlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:00:50 INFO - Running setup.py (path:/tmp/pip-iXoRFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:00:50 INFO - Running setup.py (path:/tmp/pip-GwuRYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:00:50 INFO - Running setup.py (path:/tmp/pip-mtdeKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:00:50 INFO - Running setup.py (path:/tmp/pip-vK89Sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:00:50 INFO - Running setup.py (path:/tmp/pip-vI_5to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:50 INFO - Running setup.py (path:/tmp/pip-LNovW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:00:50 INFO - Running setup.py (path:/tmp/pip-T71pCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:00:50 INFO - Running setup.py (path:/tmp/pip-fbFu7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:00:50 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)) 05:00:50 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)) 05:00:50 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)) 05:00:50 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)) 05:00:50 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)) 05:00:50 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)) 05:00:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:52 INFO - Downloading blessings-1.6.tar.gz 05:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:00:52 INFO - Installing collected packages: blessings 05:00:52 INFO - Running setup.py install for blessings 05:00:52 INFO - Successfully installed blessings 05:00:52 INFO - Cleaning up... 05:00:53 INFO - Return code: 0 05:00:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:53 INFO - Reading from file tmpfile_stdout 05:00:53 INFO - Current package versions: 05:00:53 INFO - argparse == 1.2.1 05:00:53 INFO - blessings == 1.6 05:00:53 INFO - blobuploader == 1.2.4 05:00:53 INFO - docopt == 0.6.1 05:00:53 INFO - functools32 == 3.2.3-2 05:00:53 INFO - jsonschema == 2.5.1 05:00:53 INFO - manifestparser == 1.1 05:00:53 INFO - mozInstall == 1.12 05:00:53 INFO - mozcrash == 1.0 05:00:53 INFO - mozdebug == 0.1 05:00:53 INFO - mozdevice == 0.49 05:00:53 INFO - mozfile == 1.2 05:00:53 INFO - mozhttpd == 0.7 05:00:53 INFO - mozinfo == 0.9 05:00:53 INFO - mozleak == 0.1 05:00:53 INFO - mozlog == 3.4 05:00:53 INFO - moznetwork == 0.27 05:00:53 INFO - mozprocess == 0.24 05:00:53 INFO - mozprofile == 0.28 05:00:53 INFO - mozrunner == 6.13 05:00:53 INFO - mozscreenshot == 0.1 05:00:53 INFO - mozsystemmonitor == 0.3 05:00:53 INFO - moztest == 0.8 05:00:53 INFO - mozversion == 1.4 05:00:53 INFO - psutil == 3.1.1 05:00:53 INFO - requests == 1.2.3 05:00:53 INFO - wsgiref == 0.1.2 05:00:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:53 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 0x221e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, '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': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', '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 05:00:53 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 05:00:53 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 05:00:53 INFO - Using env: {'DISPLAY': ':0', 05:00:53 INFO - 'HOME': '/home/cltbld', 05:00:53 INFO - 'LANG': 'en_US.UTF-8', 05:00:53 INFO - 'LANGUAGE': 'en_US:en', 05:00:53 INFO - 'LOGNAME': 'cltbld', 05:00:53 INFO - 'MAIL': '/var/mail/cltbld', 05:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:53 INFO - 'MOZ_NO_REMOTE': '1', 05:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:53 INFO - 'NO_EM_RESTART': '1', 05:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:53 INFO - 'PWD': '/builds/slave/test', 05:00:53 INFO - 'SHELL': '/bin/bash', 05:00:53 INFO - 'SHLVL': '1', 05:00:53 INFO - 'TERM': 'linux', 05:00:53 INFO - 'TMOUT': '86400', 05:00:53 INFO - 'USER': 'cltbld', 05:00:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:53 INFO - '_': '/tools/buildbot/bin/python'} 05:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:53 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)) 05:00:53 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)) 05:00:53 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)) 05:00:53 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)) 05:00:53 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)) 05:00:53 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)) 05:00:53 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)) 05:00:53 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)) 05:00:53 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)) 05:00:53 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)) 05:00:53 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)) 05:00:53 INFO - Cleaning up... 05:00:53 INFO - Return code: 0 05:00:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:53 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 0x221e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, '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': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', '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 05:00:53 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 05:00:53 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 05:00:53 INFO - Using env: {'DISPLAY': ':0', 05:00:53 INFO - 'HOME': '/home/cltbld', 05:00:53 INFO - 'LANG': 'en_US.UTF-8', 05:00:53 INFO - 'LANGUAGE': 'en_US:en', 05:00:53 INFO - 'LOGNAME': 'cltbld', 05:00:53 INFO - 'MAIL': '/var/mail/cltbld', 05:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:53 INFO - 'MOZ_NO_REMOTE': '1', 05:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:53 INFO - 'NO_EM_RESTART': '1', 05:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:53 INFO - 'PWD': '/builds/slave/test', 05:00:53 INFO - 'SHELL': '/bin/bash', 05:00:53 INFO - 'SHLVL': '1', 05:00:53 INFO - 'TERM': 'linux', 05:00:53 INFO - 'TMOUT': '86400', 05:00:53 INFO - 'USER': 'cltbld', 05:00:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:53 INFO - '_': '/tools/buildbot/bin/python'} 05:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:00:53 INFO - Cleaning up... 05:00:53 INFO - Return code: 0 05:00:53 INFO - Running post-action listener: _resource_record_post_action 05:00:53 INFO - Running post-action listener: _start_resource_monitoring 05:00:53 INFO - Starting resource monitoring. 05:00:53 INFO - [mozharness: 2017-01-31 13:00:53.752683Z] Finished create-virtualenv step (success) 05:00:53 INFO - [mozharness: 2017-01-31 13:00:53.753191Z] Running install step. 05:00:53 INFO - Running pre-action listener: _resource_record_pre_action 05:00:53 INFO - Running main action method: install 05:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:53 INFO - Reading from file tmpfile_stdout 05:00:53 INFO - Detecting whether we're running mozinstall >=1.0... 05:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:00:54 INFO - Reading from file tmpfile_stdout 05:00:54 INFO - Output received: 05:00:54 INFO - Usage: mozinstall [options] installer 05:00:54 INFO - Options: 05:00:54 INFO - -h, --help show this help message and exit 05:00:54 INFO - -d DEST, --destination=DEST 05:00:54 INFO - Directory to install application into. [default: 05:00:54 INFO - "/builds/slave/test"] 05:00:54 INFO - --app=APP Application being installed. [default: firefox] 05:00:54 INFO - mkdir: /builds/slave/test/build/application 05:00:54 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'] 05:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:01:11 INFO - Reading from file tmpfile_stdout 05:01:11 INFO - Output received: 05:01:11 INFO - /builds/slave/test/build/application/firefox/firefox 05:01:11 INFO - Running post-action listener: _resource_record_post_action 05:01:11 INFO - [mozharness: 2017-01-31 13:01:11.592712Z] Finished install step (success) 05:01:11 INFO - [mozharness: 2017-01-31 13:01:11.592989Z] Running run-tests step. 05:01:11 INFO - Running pre-action listener: _resource_record_pre_action 05:01:11 INFO - Running main action method: run_tests 05:01:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:01:11 INFO - Python 2.7.3 05:01:11 INFO - Return code: 0 05:01:11 INFO - grabbing minidump binary from tooltool 05:01:11 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')]} 05:01:11 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 0x258d3f0>, '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 0x258dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:01:11 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 05:01:11 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 05:01:11 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 05:01:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:01:11 INFO - Return code: 0 05:01:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:01:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:01:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:01:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:01:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:01:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 05:01:11 INFO - Using env: {'DISPLAY': ':0', 05:01:11 INFO - 'HOME': '/home/cltbld', 05:01:11 INFO - 'LANG': 'en_US.UTF-8', 05:01:11 INFO - 'LANGUAGE': 'en_US:en', 05:01:11 INFO - 'LOGNAME': 'cltbld', 05:01:11 INFO - 'MAIL': '/var/mail/cltbld', 05:01:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:01:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:11 INFO - 'MOZ_NO_REMOTE': '1', 05:01:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:11 INFO - 'NO_EM_RESTART': '1', 05:01:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:11 INFO - 'PWD': '/builds/slave/test', 05:01:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:01:11 INFO - 'SHELL': '/bin/bash', 05:01:11 INFO - 'SHLVL': '1', 05:01:11 INFO - 'TERM': 'linux', 05:01:11 INFO - 'TMOUT': '86400', 05:01:11 INFO - 'USER': 'cltbld', 05:01:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283', 05:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:11 INFO - '_': '/tools/buildbot/bin/python'} 05:01:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:01:11 INFO - mozversion application_buildid: 20170131120650 05:01:11 INFO - mozversion application_changeset: adab5d5d0372d1a26685d6fbc59cdfc977ad76c6 05:01:11 INFO - mozversion application_display_name: Nightly 05:01:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:01:11 INFO - mozversion application_name: Firefox 05:01:11 INFO - mozversion application_remotingname: firefox 05:01:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:01:11 INFO - mozversion application_vendor: Mozilla 05:01:11 INFO - mozversion application_version: 54.0a1 05:01:11 INFO - mozversion platform_buildid: 20170131120650 05:01:11 INFO - mozversion platform_changeset: adab5d5d0372d1a26685d6fbc59cdfc977ad76c6 05:01:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:01:11 INFO - mozversion platform_version: 54.0a1 05:01:11 INFO - using testdate: 1485867671 05:01:11 INFO - actual date: 1485867671 05:01:11 INFO - starting webserver on 'localhost:45627' 05:01:11 INFO - SUITE-START | Running 2 tests 05:01:11 INFO - TEST-START | dromaeo_css 05:01:11 INFO - operating with platform_type : linux_ 05:01:11 INFO - Initialising browser for dromaeo_css test... 05:01:11 INFO - TEST-INFO | started process 29156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIKfhq9/profile http://localhost:45627/getInfo.html) 05:01:15 INFO - PROCESS | 29156 | 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] 05:01:15 INFO - PROCESS | 29156 | __metrics Screen width/height:1600/1200 05:01:15 INFO - PROCESS | 29156 | colorDepth:24 05:01:15 INFO - PROCESS | 29156 | Browser inner width/height: 1024/697 05:01:15 INFO - PROCESS | 29156 | __metrics 05:01:16 INFO - PROCESS | 29156 | 1485867676354 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 05:01:16 INFO - PROCESS | 29156 | 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" 05:01:16 INFO - PROCESS | 29156 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:01:17 INFO - PROCESS | 29156 | console.error: PushService: 05:01:17 INFO - PROCESS | 29156 | stateChangeProcessEnqueue: Error transitioning state 05:01:17 INFO - PROCESS | 29156 | UnknownError 05:01:17 INFO - TEST-INFO | 29156: exit 0 05:01:17 INFO - Browser initialized. 05:01:17 INFO - Running cycle 1/1 for dromaeo_css test... 05:01:17 INFO - TEST-INFO | started process 29238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIKfhq9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:29 INFO - PROCESS | 29238 | RSS: Main: 149086208 05:01:29 INFO - PROCESS | 29238 | 05:04:30 INFO - PROCESS | 29238 | Cycle 1(1): loaded http://localhost:45627/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45627/tests/dromaeo/cssquery-ext.html) 05:04:33 INFO - PROCESS | 29238 | RSS: Main: 367443968 05:04:33 INFO - PROCESS | 29238 | 05:06:19 INFO - PROCESS | 29238 | ************************* 05:06:19 INFO - PROCESS | 29238 | A coding exception was thrown and uncaught in a Task. 05:06:19 INFO - PROCESS | 29238 | 05:06:19 ERROR - PROCESS | 29238 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:06:19 INFO - PROCESS | 29238 | Full stack: 05:06:19 INFO - PROCESS | 29238 | ************************* 05:07:35 INFO - PROCESS | 29238 | Cycle 1(1): loaded http://localhost:45627/tests/dromaeo/cssquery-ext.html (next: http://localhost:45627/tests/dromaeo/cssquery-jquery.html) 05:07:36 INFO - PROCESS | 29238 | RSS: Main: 247234560 05:07:36 INFO - PROCESS | 29238 | 05:10:38 INFO - PROCESS | 29238 | Cycle 1(1): loaded http://localhost:45627/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45627/tests/dromaeo/cssquery-mootools.html) 05:10:38 INFO - PROCESS | 29238 | RSS: Main: 185753600 05:10:38 INFO - PROCESS | 29238 | 05:13:40 INFO - PROCESS | 29238 | Cycle 1(1): loaded http://localhost:45627/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45627/tests/dromaeo/cssquery-prototype.html) 05:13:41 INFO - PROCESS | 29238 | RSS: Main: 184692736 05:13:41 INFO - PROCESS | 29238 | 05:16:44 INFO - PROCESS | 29238 | Cycle 1(1): loaded http://localhost:45627/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45627/tests/dromaeo/cssquery-yui.html) 05:16:44 INFO - PROCESS | 29238 | RSS: Main: 186777600 05:16:44 INFO - PROCESS | 29238 | 05:19:47 INFO - PROCESS | 29238 | Cycle 1(1): loaded http://localhost:45627/tests/dromaeo/cssquery-yui.html (next: http://localhost:45627/tests/dromaeo/cssquery-dojo.html) 05:19:47 INFO - PROCESS | 29238 | RSS: Main: 283090944 05:19:47 INFO - PROCESS | 29238 | 05:19:47 INFO - PROCESS | 29238 | __start_tp_report 05:19:47 INFO - PROCESS | 29238 | _x_x_mozilla_page_load 05:19:47 INFO - PROCESS | 29238 | _x_x_mozilla_page_load_details 05:19:47 INFO - PROCESS | 29238 | |i|pagename|runs| 05:19:47 INFO - PROCESS | 29238 | |0;dojo.html;3181.2683082890935;3215.9999999999986;3219.7102260796532;3250.7074363307297;3275.721563667088;5332.253484512172;5333.946660533394;5378.031954248234;5400.162974738917;5447.210154527591;5328.254044433782;5350.625456218067;5387.568994480442;5399.001184780808;5428.70142142183;4867.3915760529935;4883.145449546333;4889.926651100236;4899.6815207011605;4997.275395067713;4974.900501989958;4991.525805048533;4997.725125118117;5000.599952003831;5001.574866136383;4796.448408433005;4823.324734537167;4944.98627781304;4945.134601444769;5023.346964894577;4857.392825896763;4874.390701162355;4906.043321552299;4923.556879880792;4964.67729597575;4819.156647586658;4834.685745426571;4844.66087373884;4873.34209881665;4902.411710594716;5324.733763311819;5409.215663728737;5415.0523658360025;5418.810341638064;5425.755840987165;5723.599348045638;5758.366579676274;5763.020286551255;5766.538676905838;5832.533397328203;5816.854578635525;5828.9417105828825;5835.299764028344;5836.854078648068;5846.941530584682;5447.809326673548;5448.128299472145;5452.291202143736;5455.509004189642;5456.154296084073;5877.529797616266;5907.763689452459;5920.496757775637;5958.6722730249385;5967.015442452033;5692.203091567184;5728.054870946247;5735.1684005818925;5742.167385729046;5794.594378393556;5773.24947756789;5779.219805326227;5796.1595568642315;5825.79609713658;5829.679367634736;5756.597038207286;5801.506871915934;5807;5808.82573522795;5812.564057695689;5847.152162936351;5864.824055278348;5867.237259156283;5893.145493903446;5916.881662366729;4526.841560545431;4533.38799262102;4533.5013148553635;4533.591976722045;4571.725696458223;3988.481497405319;3993.5008123984503;4028.274910516135;4037.9394309085387;4095.9590404096175;5440.782368705287;5495.780168793283;5508.9724551376985;5514.476124768141;5520.227168196456;5800.5939584229545;5829.970850145722;5845.620034697816;5852.122181672783;5852.561057920588;5441.918371224435;5468.7265636718;5473.75368108436;5504.422035686195;5520.723963801875;4865.0756356292195;4931.975340123348;4956.207006878882;4973.50264973507;5026.698398096126;6047.78832740852;6048.0625503047095;6049.032154855202;6059.818205453844;6068.059450785136;5700.657960522382;5822;5823.242978412779;5824.068149096124;5827.1841942127285;5950.137230101697;5970.373110823301;6020.307664618625;6022.2171117754415;6031.819045428644;5679.233303503974;5690.345610254708;5718.79984200551;5719.599628025998;5721.628094173865;5834.18321434991;5854.063349864001;5858.7070646468355;5886.941130588811;5907.5273978080795;5698.6580805151825;5710.828675139753;5713.914291285717;5713.942860571341;5715.742791574306;5610.971945140248;5641.746121424628;5679.659220446786;5697.715114244188;5698;5575.972120139373;5701.287339082614;5752.338481074563;5788.421157884178;5789.073748200268;5635.915461268166;5681.886362272814;5719.056355701263;5722.599418040863;5737.139429085671;5562.443755624405;5597.63615365;5613.859653508695;5622.915656265078;5641.464060914206 05:19:47 INFO - PROCESS | 29238 | |1;ext.html;567.7728908436626;594.0851089322443;625.8967270400384;631.8546734251122;636.1793286660209;43290.78354608227;46130;46276.30585541215;49813.50186498134;49849;47194;47590.52409475913;47631.28553071698;47661.76169119158;47779.54976078228;8698.739037828875;9075.500847453404;9267.351285410025;9283.93234777999;9301.581428835685;8242;10922.726931826688;11091.778164436706;11204.327740335566;11507.079433645331;11103.167262455348;11148.05241554469;11162.330260184415;11169.441527923613;11175;11139.053180479668;11206.943965280121;11209.159313051554;11211.047060999825;11215.551377944872;11029.503672334764;11099.167562432849;11103.83344249837;11105.72235694106;11109.611163609236;44732.77633611843;44955.550444495464;44977.77511112456;44988;45022.774886125684;4246.851360202409;4289.613934745857;4300.35494675798;4320.395144679747;4398.6700997425005;31798.523022154684;32271.838640806647;32308.838455807807;32616.347673046643;32664.346713065606;4126.958730412687;4221.050263690676;4228.238916994939;4229.767362795045;4361.214981303364;297265;298126;299561;299949;300122.49938750383;57327.14009289864;57379;57495.425045749005;57535;57596.712016440484;64840.67579662166;65240;65296.673516632116;65323.34676653173;65383.67308163429;17258.741118883227;17463.476095716895;17472.301107955795;17476.126193690263;17482.912585436992;12546.874531254753;12846.550370736979;13184.340782961006;13522.93238533801;13603.795943060863;17539.912300438416;17558;17634.294628214986;17710;17773.644527109387;6682.699278532477;6729.192496900403;6834.521583489108;6939.93060069403;7042.753503627348;878.446578655443;903.620479398641;918.2653876898454;925.4077390470104;962.7352478068448;30247.546286805275;31395.37209255802;31442.685573144434;31559.684403156134;31664.208394790316;1012.1346248957183;1038.231708535678;1043.7860238651058;1054.3515737821338;1071.9732006699894;16526.256318465697;16692.165391730367;16825.747613785803;16957.83042169587;16995.660086798194;449880;451030;451156;452382;453701;62897.685511573065;63228.36771632317;63293;63295;63327.36672633307;1409.5348534983432;1459.3432955170215;1464.0629996802056;1467.662437639349;1475.6163397516723;29187.562186566793;30131.213676579748;30602.540961886036;30778.692213078477;30852.22869428282;52492.737536312074;53151;53170.468295316554;53285;53297.4670253308;289140;290231;290310;290477;290488;39560.40659390169;40509;40509;40765.38851917164;40962.385564217155;45216.54783452255;45916.77041614771;45992.31011534896;46324.53675463337;46688;35426;37047.444288336235;37898.24203515859;38178.80910595429;38250.617493824706;36556;36956.63043369532;37228.6277137236;37410.43884341791;37506.62493375031;36500.269994599425;36820.63179368279;37170.25659486849;37308.81345593255;38137;31197.220069497536;32233.838830805696;32424.513632296006;32815.67184328126;32975.34049318952;24601.384965376008;24763.13329033475;24831.751682482944;24934.875325623256;25210.74789252084 05:19:47 INFO - PROCESS | 29238 | |2;jquery.html;397;433.0991537601788;438.9312025218593;440.0999955091837;446.47306212752386;16611.252493637785;20373.796262037395;20552.794472055273;21045.473863153427;21723.456913577167;21589.67615485769;21609.67585486215;21655.67516487254;21766.782332176674;21969.560608787815;4797.568218860293;5971.85070373242;5995.070764031582;5998.97000514999;6030.306514750816;5960.0761881908375;5963.582549221556;6049.425304596057;6060.636361818283;6061.484773794233;6173;6305.432511074003;6324.3043265240785;6325.936740632581;6344.587601805891;6074.848128796793;6167.629942203437;6228.875422491525;6314.905276420857;6321.968390158066;6107.4808641265545;6112.327643959161;6112.63324200545;6114.327423983358;6115.143879856779;14094.50669226572;14117.152970821784;14276.643083922985;14336.856631433657;14347.497837575635;2654.495645827287;2739.5890616407696;2774.403503246812;2802.2153796936686;2824.2798086487815;10610.151187904949;10943.781124377547;10947.4526273686;10962.451877406178;11182.105431565536;1920.9039548022542;1954.0264333023606;1974;1980.6137803128395;1993.9302124425576;67812;69580.6520967397;87167;89974;95718.9999999993;11476.163813789753;11783.705407364712;11829.171957963032;12064.605758947771;12077.396130193456;16857.072860992765;16865;16903.492895213163;16915.23881425339;16928;8571.871421928676;8703.129687031373;8797.516136612549;8975.37172397939;9038.774030649154;8289.502629842229;8365.874511882326;8423.749692042375;8599.914000860037;8643.956780216184;5123.357595235821;5181.5077567631015;5248.816291429858;5252.1596544552685;5327.3074500314715;2098.4124445155076;2178.8692678439343;2184.8252139828774;2199.175309259028;2208.094681180708;871.5119533061505;894.1952242981368;895.7178488776015;896.4486840593119;915.9542022898828;18941.905290473736;19901.502462438264;20079.39761807148;20113.597728045355;20171.394858153984;884.6240347852137;897.699270744295;903.5708038681705;908.4367692030983;912.5710915869531;10480.371177729361;11024.944875275572;11035.944820275847;11037.503312350964;11050.668479945614;577295;583399;586817.3295667643;592294;596346;93216;95135.52432237794;106094;108903;109546.45226773975;1047.2878442658912;1081.5295346524445;1100.2298391126244;1107.0258172807878;1109.295597295723;17946.820531794514;18174.909125454287;18791.624167516846;18893.244270229035;18979.525511862314;47053.764731176125;47768;47910.28134578054;47956.5204347952;48454.27318590153;68130;68461.3153868455;68603.3139668617;69159;69441.65279173572;8399.41204115706;8496;8504.22434651539;8751;8830.602622882114;9365.906340936775;12794.488220471078;13073.15024523403;13249.80125298102;13819.930900345435;11452.198346115692;11493.885061149282;11609.535618575163;11967.76064478723;12114.93942530317;11099.334039957628;11244.156688248251;11287.774244515227;11335.376554289593;11495.252808567417;10954.39750813681;11112;11668.533258669559;12049.939750301543;12609.180403273758;8773.473591584525;8824.3381746368;8860.424072435271;8900.643974240958;9056.456612603002;10413.073581387467;11327.433628318386;11981.041516678819;12069.456874440846;12216.938915305367 05:19:47 INFO - PROCESS | 29238 | |3;mootools.html;1326.277178937479;1338.9263590502524;1348.5347555093495;1354.3228385807097;1356.9728605427892;8191.344692424606;8639.740807775761;8651.826963460728;8663.870041949376;8664.436811607242;7637.809054773619;7853.646585903633;8180.181981801817;8371.330293576515;8403.495790252573;2347.5539647467012;2371.490129622131;2372.8694921779297;2375.9406014849596;2377.821663375245;2349.8472599281076;2380.702412198475;2383.8808059597036;2390.95993242939;2392.091005417939;2016.9394918152404;2078.064870808135;2263.7283525976904;2327.3367090379247;2337.345543247885;2321.6749655048307;2325.6278995360663;2328.324785812121;2329.860208387502;2333.7666233376694;2231.497912969569;2280.669302951063;2298.643710224918;2302.5394921015863;2303.6890019847274;8613.956930215372;8674.783130421727;8684.2618377438;8685.08806575313;8699.52152631605;5260.631755777097;5394.703291318976;5415.512603865632;5427.348718153808;5434.701091439969;3263.2657652028342;3327.434336162858;3390.7117894978956;3396.218869659992;3424.6917777400154;1284.492625412966;1369.6438925879243;1377.1943413103347;1409.0418515409517;1456.4028748213182;11593.24643898144;11645.18483706141;11672;11685.649430517013;11734.999999999915;4345.152695224401;4719.339292499053;4779.354787103766;4827.106985207678;4829.782659780319;10056.346337488187;10101.040401161878;10104.797904041878;10128.240381971382;10129.848052279222;5516.558675305966;5522.91715624266;5525;5525.972370138204;5527.447255274521;4342.6308763754805;4474.6420286377015;4959.429665588431;5038.143515602356;5048.747562621854;4007.499062617173;4019.8593049243723;4066.5933406659688;4075.144219713893;4125.29869922114;1314.3953781260536;1321.662975941129;1321.9537316193887;1321.9867801322057;1346.077936613423;1003.7641154328727;1013.1742629756725;1018.7554986803262;1025.3027941000191;1029.5727273181697;5833.591648584558;5918.319393269743;5944.494717948936;5995;6155.446009859134;626.223482881224;628.3433811666819;637.7098420218789;651.7197605029883;652.5073569455031;3847.1343947611563;3935.626115519021;4020.19596080785;4086.3053280941717;4086.7547947123267;10016.49917504122;10354.17166626668;10354.948225258826;10365.481725913674;10381.11760500366;10215;10261.12688447236;10302.587896484056;10312.587496500206;10357.223208259411;7879.409044321699;8027.959860200662;8125.1062383137805;8127.268545830785;8141.267285944294;5744.310682717934;5847.356790752929;5856.267966504187;5897.351291357862;6032.276126864805;9469.431834089977;9498.525073746147;9499.762505937408;9501.239900808057;9597.136257736836;8762.123787621187;8918.063603321558;9029.41308814925;9227.123423274777;9614.71155865325;6730.966345168243;6901.482388820758;7211.38703210212;7321.853562928818;7496.700131994659;7866.8819967701675;8209.179082091743;8212.260896519341;8217.83564328698;8223.876641850497;7170.390516805921;7301.452391070798;7301.598412087386;7465.7386991457215;7535.585542795199;7128.750493732695;7326.597037163007;7391.1500177480275;7403.111626604842;7515.586642734484;6622.768203113061;6738.124043874265;6738.225104113089;6742.5280230383405;6744.156980377453;5035.446100928822;5060.468650791761;5108.61685373591;5125.974370128126;5354;5135.974320128375;5264.2630031794815;5280.788768449219;5283;5359.276497672764 05:19:47 INFO - PROCESS | 29238 | |4;prototype.html;408.32390416687167;411.3336395040035;424.10513815848554;424.78511457232327;432.36010704157866;5269.499397557231;5315.096433606286;5316.441773613768;5318.46815318468;5320.228566857808;5027.673201241917;5041.470645582216;5142.640015198937;5184.7407629618465;5204.817831375903;4188.706790524657;4209.957900420987;4212.705110642256;4224.366345048252;4238.957610423902;4231.936520952188;4245.193413251488;4256.191323648497;4263.126059157865;4266.871993840175;4087.4481944937497;4175.269327867626;4214.620684138427;4225.19721252961;4226.415094339623;4193.748375097473;4205.600467955539;4220.725652832587;4223.873283801491;4231.894202644928;3836.462895194675;3863.208042351311;3869.1755018836407;3882.301185786557;3888.2806680764147;5019.372578427697;5062.788701506816;5113.897722045575;5160.896782064376;5199.558037566773;4903.828366007208;4907.386576677915;4913.950860491385;4942.678725882806;4949.317232141089;5504.6421982571;5517.144842549411;5596.3284405871145;5597.552195824324;5630.690312032836;4194.224068547298;4286.485621725413;4304.849330273425;4318.676099292566;4326.286162783137;5509.696966666832;5618.550515958755;5765.827025189251;5771.711414429262;5779.508741756956;4264.6801489888385;4351.4995775485595;4373.278409062533;4373.572667169751;4396.428464299621;4433.490148632948;4456.888577785517;4457.264551349056;4464.330350447394;4467.45872673927;4632.189366860786;4739.265413860857;4744.3595114659765;4763.976180119077;4775.95224047762;5509.201165831012;5539.556835453154;5539.833804985857;5541.972290138524;5557.861053473695;1445.4579532675248;1466.8313143988364;1488.3600051977753;1489.9478518252026;1499.482678475924;1074.6399956014823;1076.8692872484016;1082.626493859617;1092.306385445248;1093.6937657455926;5111.642185047085;5132.845109850254;5156.510131537498;5200.933808569234;5201.687898726089;5505.43095217861;5506.238003838813;5515.420880807537;5585.41995563642;5603.495685388335;5075.720835354017;5313.990341835039;5349.491798279158;5356.785728570813;5368.892622147613;2880.1935458071775;2890.7542858856814;2901.564765285224;2901.7243361880587;2907.0232242075167;5569.972150139223;5709.714514274269;5732.627379220337;5732.742026608729;5889.4993925515955;5741.478508195331;5809.24479817621;5813.273340832396;5819.53443724501;5820.185174075633;5781.971090144522;5785.421457854265;5827;5832.650040997469;5866.445391971217;5515.972420137874;5565.38603804892;5611.607187496836;5636.661800291996;5650.971745141248;5529.336479622471;5564.165375193753;5589.860253493695;5592.552595792408;5612.803551875828;5600.751564092898;5712.915025885975;5720.799772007959;5755.7122143893475;5865.73604187804;4071.328230841878;4077.082656402286;4100.876973690794;4119.9382009270485;4121.402396652408;5498.120300751861;5639.182318563868;5670.659760414388;5671.97904377216;5677.864427114511;5433.8369848904595;5446.782128714965;5452.537638599439;5457.317835270591;5511.972440137934;5437.8368648940595;5477.466309433365;5497.47773961473;5507.531859791962;5512.614117011771;5236.450172731808;5443.401225865073;5445.264889239902;5453.427390123979;5482.451754824486;5501.339839219159;5507.201455788808;5507.614466987273;5512.649400896806;5514.724263786715;5368.758405871823;5378.332716857786;5384.488473595002;5385.8114965976;5389.730513474389 05:19:47 INFO - PROCESS | 29238 | |5;yui.html;754.0800223727058;774.3263360876039;789.9684012639494;850.753281548351;852.6684443029409;14808.851911480882;15152.54542363728;15301.770473442893;15308.846911530882;15312.846871531296;14697.559073227794;14797.3341199646;14886.25568721565;15479.690406191869;15737.763933540977;748.1844789179793;763.6754379388765;768.5926458976751;768.6502641298224;770.3721467004401;642.8328634555025;662.5726406467826;749.8800191969286;751.5340488896892;751.7368920877703;777.2693667952107;796.2157275084038;802.5706247157772;806.8063664720454;807.3137832842067;799.6561478564245;800.0119851982796;800.0559339978822;800.3117319105564;800.5997001499279;499.459168465285;502.60043265603935;583.1748076471787;584.1208980484344;584.1792281844016;15048.623784405368;15528.767068493982;15564.299606517734;16042.197890105448;16148.59628509285;15510.14694191819;15640.374385024585;15685;16059.116748578823;16463.83536164635;12449.564265250763;12595.811062834066;12727;12838.422270997735;12877.871221287762;3710.962890371116;3737.458068580068;3774.6225377462033;3821.522309711286;3950.5654378018394;75072.24927750653;76046;76242.99999999945;78163.60918195429;78273;10754.892451075546;10833.512491937881;10836.566537338576;10924.071453926505;11076.5569377224;23151.421214469436;23277.767222327897;23375.649365259535;23390;23711.288661340186;8171.673133074611;8215.301699355503;8275.668973241123;8425.789355266168;8640.827183456297;4334.718243314174;4385.561443855653;4416.690831641754;4459.2865141577195;4562.703424277412;3647.325244829715;3720.1815600567834;3733.1973625670066;3733.738638295293;3737.9439308410397;573.5153795043182;573.7590212110923;573.985650358736;591.5474661883662;601.2724603230054;780.9609519524001;795.0777098565636;808.7302934393064;812.6830536090929;828.2628460669888;9670.419774813534;10287.889507827429;10327.638532651321;10864.239503234856;10875.401852898167;726.7948347786237;753.1903204055662;781.1641543548349;782.5695867272977;818.2472125644422;5015.24771284303;5058.215976523645;5073.847784566469;5124.180131178993;5127.53852153308;60511.69744151339;67987.3201267991;75876.62061689656;76937;78860.60569697115;67612.32387676158;68227.65886170538;68513;68547.65726171338;68620.31379686139;59989.40010599925;60797;61113;61213.693931530055;61510;9663.226941844776;9720.805583888141;9838;9882.85175722379;9884.406935583887;42558.78720606501;42765;43603.56396435995;43705.34441983309;44384.55615443804;52698.736506317226;53828;54039.72980135074;54085.18872216841;54480.455195449125;12449.564265250672;12454.813177802522;12615.810762838748;12699.428525716181;12769.8084528734;13197.934010329887;13626.523071692443;13716.862831371558;13894.374753135931;14094.71086107168;12477;12799.168054076456;13008.414621342252;13137.080404371602;13577.660558486117;11951.94024029909;12137.757244855231;12162.087843411957;12305.138640295452;12318.384080796104;11157;11663.59177428786;11689.707757306136;11692;11858.822117668069;10496.947515262375;10569.418681972566;10686.465676716289;10739.355638661706;10801.405922674328;10123.949380253052;10188.235882308709;10212.744681383025;10330.690079297634;10386.896131038593 05:19:47 INFO - PROCESS | 29238 | __end_tp_report 05:19:47 INFO - PROCESS | 29238 | __start_cc_report 05:19:47 INFO - PROCESS | 29238 | _x_x_mozilla_cycle_collect,2259 05:19:47 INFO - PROCESS | 29238 | __end_cc_report 05:19:47 INFO - PROCESS | 29238 | __startTimestamp1485868787868__endTimestamp 05:19:47 INFO - PROCESS | 29238 | 05:19:47 INFO - PROCESS | 29238 | ------- Summary: start ------- 05:19:47 INFO - PROCESS | 29238 | Number of tests: 6 05:19:47 INFO - PROCESS | 29238 | 05:19:47 INFO - PROCESS | 29238 | [#0] dojo.html Cycles:165 Average:5403.39 Median:5641.46 stddev:602.51 (10.7%) stddev-sans-first:578.59 05:19:47 INFO - PROCESS | 29238 | Values: 3181.3 3216.0 3219.7 3250.7 3275.7 5332.3 5333.9 5378.0 5400.2 5447.2 5328.3 5350.6 5387.6 5399.0 5428.7 4867.4 4883.1 4889.9 4899.7 4997.3 4974.9 4991.5 4997.7 5000.6 5001.6 4796.4 4823.3 4945.0 4945.1 5023.3 4857.4 4874.4 4906.0 4923.6 4964.7 4819.2 4834.7 4844.7 4873.3 4902.4 5324.7 5409.2 5415.1 5418.8 5425.8 5723.6 5758.4 5763.0 5766.5 5832.5 5816.9 5828.9 5835.3 5836.9 5846.9 5447.8 5448.1 5452.3 5455.5 5456.2 5877.5 5907.8 5920.5 5958.7 5967.0 5692.2 5728.1 5735.2 5742.2 5794.6 5773.2 5779.2 5796.2 5825.8 5829.7 5756.6 5801.5 5807.0 5808.8 5812.6 5847.2 5864.8 5867.2 5893.1 5916.9 4526.8 4533.4 4533.5 4533.6 4571.7 3988.5 3993.5 4028.3 4037.9 4096.0 5440.8 5495.8 5509.0 5514.5 5520.2 5800.6 5830.0 5845.6 5852.1 5852.6 5441.9 5468.7 5473.8 5504.4 5520.7 4865.1 4932.0 4956.2 4973.5 5026.7 6047.8 6048.1 6049.0 6059.8 6068.1 5700.7 5822.0 5823.2 5824.1 5827.2 5950.1 5970.4 6020.3 6022.2 6031.8 5679.2 5690.3 5718.8 5719.6 5721.6 5834.2 5854.1 5858.7 5886.9 5907.5 5698.7 5710.8 5713.9 5713.9 5715.7 5611.0 5641.7 5679.7 5697.7 5698.0 5576.0 5701.3 5752.3 5788.4 5789.1 5635.9 5681.9 5719.1 5722.6 5737.1 5562.4 5597.6 5613.9 5622.9 5641.5 05:19:47 INFO - PROCESS | 29238 | 05:19:47 INFO - PROCESS | 29238 | [#1] ext.html Cycles:180 Average:52949.26 Median:37199.44 stddev:93316.12 (250.9%) stddev-sans-first:93495.02 05:19:47 INFO - PROCESS | 29238 | Values: 567.8 594.1 625.9 631.9 636.2 43290.8 46130.0 46276.3 49813.5 49849.0 47194.0 47590.5 47631.3 47661.8 47779.5 8698.7 9075.5 9267.4 9283.9 9301.6 8242.0 10922.7 11091.8 11204.3 11507.1 11103.2 11148.1 11162.3 11169.4 11175.0 11139.1 11206.9 11209.2 11211.0 11215.6 11029.5 11099.2 11103.8 11105.7 11109.6 44732.8 44955.6 44977.8 44988.0 45022.8 4246.9 4289.6 4300.4 4320.4 4398.7 31798.5 32271.8 32308.8 32616.3 32664.3 4127.0 4221.1 4228.2 4229.8 4361.2 297265.0 298126.0 299561.0 299949.0 300122.5 57327.1 57379.0 57495.4 57535.0 57596.7 64840.7 65240.0 65296.7 65323.3 65383.7 17258.7 17463.5 17472.3 17476.1 17482.9 12546.9 12846.6 13184.3 13522.9 13603.8 17539.9 17558.0 17634.3 17710.0 17773.6 6682.7 6729.2 6834.5 6939.9 7042.8 878.4 903.6 918.3 925.4 962.7 30247.5 31395.4 31442.7 31559.7 31664.2 1012.1 1038.2 1043.8 1054.4 1072.0 16526.3 16692.2 16825.7 16957.8 16995.7 449880.0 451030.0 451156.0 452382.0 453701.0 62897.7 63228.4 63293.0 63295.0 63327.4 1409.5 1459.3 1464.1 1467.7 1475.6 29187.6 30131.2 30602.5 30778.7 30852.2 52492.7 53151.0 53170.5 53285.0 53297.5 289140.0 290231.0 290310.0 290477.0 290488.0 39560.4 40509.0 40509.0 40765.4 40962.4 45216.5 45916.8 45992.3 46324.5 46688.0 35426.0 37047.4 37898.2 38178.8 38250.6 36556.0 36956.6 37228.6 37410.4 37506.6 36500.3 36820.6 37170.3 37308.8 38137.0 31197.2 32233.8 32424.5 32815.7 32975.3 24601.4 24763.1 24831.8 24934.9 25210.7 05:19:47 INFO - PROCESS | 29238 | 05:19:47 INFO - PROCESS | 29238 | [#2] jquery.html Cycles:180 Average:32578.47 Median:2813.25 stddev:96710.29 (3437.7%) stddev-sans-first:96951.40 05:19:47 INFO - PROCESS | 29238 | Values: 397.0 433.1 438.9 440.1 446.5 16611.3 20373.8 20552.8 21045.5 21723.5 21589.7 21609.7 21655.7 21766.8 21969.6 4797.6 5971.9 5995.1 5999.0 6030.3 5960.1 5963.6 6049.4 6060.6 6061.5 6173.0 6305.4 6324.3 6325.9 6344.6 6074.8 6167.6 6228.9 6314.9 6322.0 6107.5 6112.3 6112.6 6114.3 6115.1 14094.5 14117.2 14276.6 14336.9 14347.5 2654.5 2739.6 2774.4 2802.2 2824.3 10610.2 10943.8 10947.5 10962.5 11182.1 1920.9 1954.0 1974.0 1980.6 1993.9 67812.0 69580.7 87167.0 89974.0 95719.0 11476.2 11783.7 11829.2 12064.6 12077.4 16857.1 16865.0 16903.5 16915.2 16928.0 8571.9 8703.1 8797.5 8975.4 9038.8 8289.5 8365.9 8423.7 8599.9 8644.0 5123.4 5181.5 5248.8 5252.2 5327.3 2098.4 2178.9 2184.8 2199.2 2208.1 871.5 894.2 895.7 896.4 916.0 18941.9 19901.5 20079.4 20113.6 20171.4 884.6 897.7 903.6 908.4 912.6 10480.4 11024.9 11035.9 11037.5 11050.7 577295.0 583399.0 586817.3 592294.0 596346.0 93216.0 95135.5 106094.0 108903.0 109546.5 1047.3 1081.5 1100.2 1107.0 1109.3 17946.8 18174.9 18791.6 18893.2 18979.5 47053.8 47768.0 47910.3 47956.5 48454.3 68130.0 68461.3 68603.3 69159.0 69441.7 8399.4 8496.0 8504.2 8751.0 8830.6 9365.9 12794.5 13073.2 13249.8 13819.9 11452.2 11493.9 11609.5 11967.8 12114.9 11099.3 11244.2 11287.8 11335.4 11495.3 10954.4 11112.0 11668.5 12049.9 12609.2 8773.5 8824.3 8860.4 8900.6 9056.5 10413.1 11327.4 11981.0 12069.5 12216.9 05:19:47 INFO - PROCESS | 29238 | 05:19:47 INFO - PROCESS | 29238 | [#3] mootools.html Cycles:180 Average:5621.68 Median:5054.61 stddev:3090.35 (61.1%) stddev-sans-first:3082.15 05:19:47 INFO - PROCESS | 29238 | Values: 1326.3 1338.9 1348.5 1354.3 1357.0 8191.3 8639.7 8651.8 8663.9 8664.4 7637.8 7853.6 8180.2 8371.3 8403.5 2347.6 2371.5 2372.9 2375.9 2377.8 2349.8 2380.7 2383.9 2391.0 2392.1 2016.9 2078.1 2263.7 2327.3 2337.3 2321.7 2325.6 2328.3 2329.9 2333.8 2231.5 2280.7 2298.6 2302.5 2303.7 8614.0 8674.8 8684.3 8685.1 8699.5 5260.6 5394.7 5415.5 5427.3 5434.7 3263.3 3327.4 3390.7 3396.2 3424.7 1284.5 1369.6 1377.2 1409.0 1456.4 11593.2 11645.2 11672.0 11685.6 11735.0 4345.2 4719.3 4779.4 4827.1 4829.8 10056.3 10101.0 10104.8 10128.2 10129.8 5516.6 5522.9 5525.0 5526.0 5527.4 4342.6 4474.6 4959.4 5038.1 5048.7 4007.5 4019.9 4066.6 4075.1 4125.3 1314.4 1321.7 1322.0 1322.0 1346.1 1003.8 1013.2 1018.8 1025.3 1029.6 5833.6 5918.3 5944.5 5995.0 6155.4 626.2 628.3 637.7 651.7 652.5 3847.1 3935.6 4020.2 4086.3 4086.8 10016.5 10354.2 10354.9 10365.5 10381.1 10215.0 10261.1 10302.6 10312.6 10357.2 7879.4 8028.0 8125.1 8127.3 8141.3 5744.3 5847.4 5856.3 5897.4 6032.3 9469.4 9498.5 9499.8 9501.2 9597.1 8762.1 8918.1 9029.4 9227.1 9614.7 6731.0 6901.5 7211.4 7321.9 7496.7 7866.9 8209.2 8212.3 8217.8 8223.9 7170.4 7301.5 7301.6 7465.7 7535.6 7128.8 7326.6 7391.2 7403.1 7515.6 6622.8 6738.1 6738.2 6742.5 6744.2 5035.4 5060.5 5108.6 5126.0 5354.0 5136.0 5264.3 5280.8 5283.0 5359.3 05:19:47 INFO - PROCESS | 29238 | 05:19:47 INFO - PROCESS | 29238 | [#4] prototype.html Cycles:180 Average:4692.40 Median:5220.63 stddev:1313.62 (25.2%) stddev-sans-first:1277.34 05:19:47 INFO - PROCESS | 29238 | Values: 408.3 411.3 424.1 424.8 432.4 5269.5 5315.1 5316.4 5318.5 5320.2 5027.7 5041.5 5142.6 5184.7 5204.8 4188.7 4210.0 4212.7 4224.4 4239.0 4231.9 4245.2 4256.2 4263.1 4266.9 4087.4 4175.3 4214.6 4225.2 4226.4 4193.7 4205.6 4220.7 4223.9 4231.9 3836.5 3863.2 3869.2 3882.3 3888.3 5019.4 5062.8 5113.9 5160.9 5199.6 4903.8 4907.4 4914.0 4942.7 4949.3 5504.6 5517.1 5596.3 5597.6 5630.7 4194.2 4286.5 4304.8 4318.7 4326.3 5509.7 5618.6 5765.8 5771.7 5779.5 4264.7 4351.5 4373.3 4373.6 4396.4 4433.5 4456.9 4457.3 4464.3 4467.5 4632.2 4739.3 4744.4 4764.0 4776.0 5509.2 5539.6 5539.8 5542.0 5557.9 1445.5 1466.8 1488.4 1489.9 1499.5 1074.6 1076.9 1082.6 1092.3 1093.7 5111.6 5132.8 5156.5 5200.9 5201.7 5505.4 5506.2 5515.4 5585.4 5603.5 5075.7 5314.0 5349.5 5356.8 5368.9 2880.2 2890.8 2901.6 2901.7 2907.0 5570.0 5709.7 5732.6 5732.7 5889.5 5741.5 5809.2 5813.3 5819.5 5820.2 5782.0 5785.4 5827.0 5832.7 5866.4 5516.0 5565.4 5611.6 5636.7 5651.0 5529.3 5564.2 5589.9 5592.6 5612.8 5600.8 5712.9 5720.8 5755.7 5865.7 4071.3 4077.1 4100.9 4119.9 4121.4 5498.1 5639.2 5670.7 5672.0 5677.9 5433.8 5446.8 5452.5 5457.3 5512.0 5437.8 5477.5 5497.5 5507.5 5512.6 5236.5 5443.4 5445.3 5453.4 5482.5 5501.3 5507.2 5507.6 5512.6 5514.7 5368.8 5378.3 5384.5 5385.8 5389.7 05:19:47 INFO - PROCESS | 29238 | 05:19:47 INFO - PROCESS | 29238 | [#5] yui.html Cycles:180 Average:17228.15 Median:24400.62 stddev:21635.39 (88.7%) stddev-sans-first:21660.72 05:19:47 INFO - PROCESS | 29238 | Values: 754.1 774.3 790.0 850.8 852.7 14808.9 15152.5 15301.8 15308.8 15312.8 14697.6 14797.3 14886.3 15479.7 15737.8 748.2 763.7 768.6 768.7 770.4 642.8 662.6 749.9 751.5 751.7 777.3 796.2 802.6 806.8 807.3 799.7 800.0 800.1 800.3 800.6 499.5 502.6 583.2 584.1 584.2 15048.6 15528.8 15564.3 16042.2 16148.6 15510.1 15640.4 15685.0 16059.1 16463.8 12449.6 12595.8 12727.0 12838.4 12877.9 3711.0 3737.5 3774.6 3821.5 3950.6 75072.2 76046.0 76243.0 78163.6 78273.0 10754.9 10833.5 10836.6 10924.1 11076.6 23151.4 23277.8 23375.6 23390.0 23711.3 8171.7 8215.3 8275.7 8425.8 8640.8 4334.7 4385.6 4416.7 4459.3 4562.7 3647.3 3720.2 3733.2 3733.7 3737.9 573.5 573.8 574.0 591.5 601.3 781.0 795.1 808.7 812.7 828.3 9670.4 10287.9 10327.6 10864.2 10875.4 726.8 753.2 781.2 782.6 818.2 5015.2 5058.2 5073.8 5124.2 5127.5 60511.7 67987.3 75876.6 76937.0 78860.6 67612.3 68227.7 68513.0 68547.7 68620.3 59989.4 60797.0 61113.0 61213.7 61510.0 9663.2 9720.8 9838.0 9882.9 9884.4 42558.8 42765.0 43603.6 43705.3 44384.6 52698.7 53828.0 54039.7 54085.2 54480.5 12449.6 12454.8 12615.8 12699.4 12769.8 13197.9 13626.5 13716.9 13894.4 14094.7 12477.0 12799.2 13008.4 13137.1 13577.7 11951.9 12137.8 12162.1 12305.1 12318.4 11157.0 11663.6 11689.7 11692.0 11858.8 10496.9 10569.4 10686.5 10739.4 10801.4 10123.9 10188.2 10212.7 10330.7 10386.9 05:19:47 INFO - PROCESS | 29238 | -------- Summary: end -------- 05:19:47 INFO - PROCESS | 29238 | 05:19:48 INFO - TEST-INFO | 29238: exit 0 05:19:48 INFO - TEST-OK | dromaeo_css | took 1116826ms 05:19:48 INFO - TEST-START | kraken 05:19:48 INFO - operating with platform_type : linux_ 05:19:48 INFO - Initialising browser for kraken test... 05:19:48 INFO - TEST-INFO | started process 29544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDkIhIf/profile http://localhost:45627/getInfo.html) 05:19:52 INFO - PROCESS | 29544 | 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] 05:19:52 INFO - PROCESS | 29544 | __metrics Screen width/height:1600/1200 05:19:52 INFO - PROCESS | 29544 | colorDepth:24 05:19:52 INFO - PROCESS | 29544 | Browser inner width/height: 1024/697 05:19:52 INFO - PROCESS | 29544 | __metrics 05:19:53 INFO - PROCESS | 29544 | 1485868793082 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 05:19:53 INFO - PROCESS | 29544 | 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" 05:19:53 INFO - PROCESS | 29544 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:19:53 INFO - PROCESS | 29544 | console.error: PushService: 05:19:53 INFO - PROCESS | 29544 | stateChangeProcessEnqueue: Error transitioning state 05:19:53 INFO - PROCESS | 29544 | UnknownError 05:19:54 INFO - TEST-INFO | 29544: exit 0 05:19:54 INFO - Browser initialized. 05:19:54 INFO - Running cycle 1/1 for kraken test... 05:19:54 INFO - TEST-INFO | started process 29629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDkIhIf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:06 INFO - PROCESS | 29629 | RSS: Main: 149237760 05:20:06 INFO - PROCESS | 29629 | 05:20:08 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45627/tests/kraken/driver.html?testName=audio-beat-detection) 05:20:09 INFO - PROCESS | 29629 | RSS: Main: 205234176 05:20:09 INFO - PROCESS | 29629 | 05:20:12 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45627/tests/kraken/driver.html?testName=audio-dft) 05:20:12 INFO - PROCESS | 29629 | RSS: Main: 184397824 05:20:12 INFO - PROCESS | 29629 | 05:20:15 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45627/tests/kraken/driver.html?testName=audio-fft) 05:20:16 INFO - PROCESS | 29629 | RSS: Main: 265789440 05:20:16 INFO - PROCESS | 29629 | 05:20:18 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45627/tests/kraken/driver.html?testName=audio-oscillator) 05:20:19 INFO - PROCESS | 29629 | RSS: Main: 176463872 05:20:19 INFO - PROCESS | 29629 | 05:20:21 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45627/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:20:21 INFO - PROCESS | 29629 | RSS: Main: 181129216 05:20:21 INFO - PROCESS | 29629 | 05:20:24 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45627/tests/kraken/driver.html?testName=imaging-darkroom) 05:20:25 INFO - PROCESS | 29629 | RSS: Main: 220368896 05:20:25 INFO - PROCESS | 29629 | 05:20:28 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45627/tests/kraken/driver.html?testName=imaging-desaturate) 05:20:29 INFO - PROCESS | 29629 | RSS: Main: 220450816 05:20:29 INFO - PROCESS | 29629 | 05:20:32 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45627/tests/kraken/driver.html?testName=json-parse-financial) 05:20:32 INFO - PROCESS | 29629 | RSS: Main: 218992640 05:20:32 INFO - PROCESS | 29629 | 05:20:34 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45627/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:35 INFO - PROCESS | 29629 | RSS: Main: 181538816 05:20:35 INFO - PROCESS | 29629 | 05:20:36 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45627/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:37 INFO - PROCESS | 29629 | RSS: Main: 188641280 05:20:37 INFO - PROCESS | 29629 | 05:20:39 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45627/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:40 INFO - PROCESS | 29629 | RSS: Main: 196825088 05:20:40 INFO - PROCESS | 29629 | 05:20:42 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45627/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:20:43 INFO - PROCESS | 29629 | RSS: Main: 206848000 05:20:43 INFO - PROCESS | 29629 | 05:20:46 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45627/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:46 INFO - PROCESS | 29629 | RSS: Main: 203100160 05:20:46 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | Cycle 1(1): loaded http://localhost:45627/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45627/tests/kraken/driver.html?testName=ai-astar) 05:20:48 INFO - PROCESS | 29629 | RSS: Main: 254550016 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | __start_tp_report 05:20:48 INFO - PROCESS | 29629 | _x_x_mozilla_page_load 05:20:48 INFO - PROCESS | 29629 | _x_x_mozilla_page_load_details 05:20:48 INFO - PROCESS | 29629 | |i|pagename|runs| 05:20:48 INFO - PROCESS | 29629 | |0;ai-astar;105;113;114;113;113;111;111;112;110;111 05:20:48 INFO - PROCESS | 29629 | |1;audio-beat-detection;155;120;126;159;124;125;124;118;136;119 05:20:48 INFO - PROCESS | 29629 | |2;audio-dft;163;161;160;162;162;162;164;163;161;164 05:20:48 INFO - PROCESS | 29629 | |3;audio-fft;76;76;77;104;77;77;75;75;93;75 05:20:48 INFO - PROCESS | 29629 | |4;audio-oscillator;83;82;102;84;82;83;105;85;82;106 05:20:48 INFO - PROCESS | 29629 | |5;imaging-gaussian-blur;117;116;117;117;119;117;117;117;117;117 05:20:48 INFO - PROCESS | 29629 | |6;imaging-darkroom;147;147;148;147;148;146;146;146;148;146 05:20:48 INFO - PROCESS | 29629 | |7;imaging-desaturate;97;96;96;96;96;96;96;95;96;96 05:20:48 INFO - PROCESS | 29629 | |8;json-parse-financial;54;54;53;54;55;55;56;55;57;55 05:20:48 INFO - PROCESS | 29629 | |9;json-stringify-tinderbox;66;66;67;67;67;66;67;66;67;67 05:20:48 INFO - PROCESS | 29629 | |10;stanford-crypto-aes;87;86;82;81;87;81;83;88;80;81 05:20:48 INFO - PROCESS | 29629 | |11;stanford-crypto-ccm;128;131;126;124;123;125;130;128;169;152 05:20:48 INFO - PROCESS | 29629 | |12;stanford-crypto-pbkdf2;176;173;176;175;171;167;170;171;173;169 05:20:48 INFO - PROCESS | 29629 | |13;stanford-crypto-sha256-iterative;64;63;63;63;64;62;62;61;62;61 05:20:48 INFO - PROCESS | 29629 | __end_tp_report 05:20:48 INFO - PROCESS | 29629 | __start_cc_report 05:20:48 INFO - PROCESS | 29629 | _x_x_mozilla_cycle_collect,1544 05:20:48 INFO - PROCESS | 29629 | __end_cc_report 05:20:48 INFO - PROCESS | 29629 | __startTimestamp1485868848798__endTimestamp 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | ------- Summary: start ------- 05:20:48 INFO - PROCESS | 29629 | Number of tests: 14 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:2.54 (2.3%) stddev-sans-first:1.32 05:20:48 INFO - PROCESS | 29629 | Values: 105.0 113.0 114.0 113.0 113.0 111.0 111.0 112.0 110.0 111.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:125.50 stddev:14.82 (11.8%) stddev-sans-first:12.82 05:20:48 INFO - PROCESS | 29629 | Values: 155.0 120.0 126.0 159.0 124.0 125.0 124.0 118.0 136.0 119.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.32 (0.8%) stddev-sans-first:1.36 05:20:48 INFO - PROCESS | 29629 | Values: 163.0 161.0 160.0 162.0 162.0 162.0 164.0 163.0 161.0 164.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.50 stddev:9.87 (12.9%) stddev-sans-first:10.33 05:20:48 INFO - PROCESS | 29629 | Values: 76.0 76.0 77.0 104.0 77.0 77.0 75.0 75.0 93.0 75.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:82.50 stddev:10.39 (12.6%) stddev-sans-first:10.76 05:20:48 INFO - PROCESS | 29629 | Values: 83.0 82.0 102.0 84.0 82.0 83.0 105.0 85.0 82.0 106.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 05:20:48 INFO - PROCESS | 29629 | Values: 117.0 116.0 117.0 117.0 119.0 117.0 117.0 117.0 117.0 117.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 05:20:48 INFO - PROCESS | 29629 | Values: 147.0 147.0 148.0 147.0 148.0 146.0 146.0 146.0 148.0 146.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 05:20:48 INFO - PROCESS | 29629 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.14 (2.1%) stddev-sans-first:1.17 05:20:48 INFO - PROCESS | 29629 | Values: 54.0 54.0 53.0 54.0 55.0 55.0 56.0 55.0 57.0 55.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:20:48 INFO - PROCESS | 29629 | Values: 66.0 66.0 67.0 67.0 67.0 66.0 67.0 66.0 67.0 67.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.50 stddev:3.06 (3.6%) stddev-sans-first:2.99 05:20:48 INFO - PROCESS | 29629 | Values: 87.0 86.0 82.0 81.0 87.0 81.0 83.0 88.0 80.0 81.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:129.00 stddev:14.95 (11.6%) stddev-sans-first:15.71 05:20:48 INFO - PROCESS | 29629 | Values: 128.0 131.0 126.0 124.0 123.0 125.0 130.0 128.0 169.0 152.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.00 stddev:3.03 (1.8%) stddev-sans-first:2.87 05:20:48 INFO - PROCESS | 29629 | Values: 176.0 173.0 176.0 175.0 171.0 167.0 170.0 171.0 173.0 169.0 05:20:48 INFO - PROCESS | 29629 | 05:20:48 INFO - PROCESS | 29629 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.08 (1.7%) stddev-sans-first:1.00 05:20:48 INFO - PROCESS | 29629 | Values: 64.0 63.0 63.0 63.0 64.0 62.0 62.0 61.0 62.0 61.0 05:20:48 INFO - PROCESS | 29629 | -------- Summary: end -------- 05:20:48 INFO - PROCESS | 29629 | 05:20:49 INFO - TEST-INFO | 29629: exit 0 05:20:49 INFO - TEST-OK | kraken | took 61102ms 05:20:49 INFO - SUITE-END | took 1177s 05:20:49 INFO - Completed test suite (00:19:38) 05:20:49 INFO - javascript benchmark 05:20:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7247.761070098547, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3181.2683082890935, 3215.9999999999986, 3219.7102260796532, 3250.7074363307297, 3275.721563667088, 5332.253484512172, 5333.946660533394, 5378.031954248234, 5400.162974738917, 5447.210154527591, 5328.254044433782, 5350.625456218067, 5387.568994480442, 5399.001184780808, 5428.70142142183, 4867.3915760529935, 4883.145449546333, 4889.926651100236, 4899.6815207011605, 4997.275395067713, 4974.900501989958, 4991.525805048533, 4997.725125118117, 5000.599952003831, 5001.574866136383, 4796.448408433005, 4823.324734537167, 4944.98627781304, 4945.134601444769, 5023.346964894577, 4857.392825896763, 4874.390701162355, 4906.043321552299, 4923.556879880792, 4964.67729597575, 4819.156647586658, 4834.685745426571, 4844.66087373884, 4873.34209881665, 4902.411710594716, 5324.733763311819, 5409.215663728737, 5415.0523658360025, 5418.810341638064, 5425.755840987165, 5723.599348045638, 5758.366579676274, 5763.020286551255, 5766.538676905838, 5832.533397328203, 5816.854578635525, 5828.9417105828825, 5835.299764028344, 5836.854078648068, 5846.941530584682, 5447.809326673548, 5448.128299472145, 5452.291202143736, 5455.509004189642, 5456.154296084073, 5877.529797616266, 5907.763689452459, 5920.496757775637, 5958.6722730249385, 5967.015442452033, 5692.203091567184, 5728.054870946247, 5735.1684005818925, 5742.167385729046, 5794.594378393556, 5773.24947756789, 5779.219805326227, 5796.1595568642315, 5825.79609713658, 5829.679367634736, 5756.597038207286, 5801.506871915934, 5807.0, 5808.82573522795, 5812.564057695689, 5847.152162936351, 5864.824055278348, 5867.237259156283, 5893.145493903446, 5916.881662366729, 4526.841560545431, 4533.38799262102, 4533.5013148553635, 4533.591976722045, 4571.725696458223, 3988.481497405319, 3993.5008123984503, 4028.274910516135, 4037.9394309085387, 4095.9590404096175, 5440.782368705287, 5495.780168793283, 5508.9724551376985, 5514.476124768141, 5520.227168196456, 5800.5939584229545, 5829.970850145722, 5845.620034697816, 5852.122181672783, 5852.561057920588, 5441.918371224435, 5468.7265636718, 5473.75368108436, 5504.422035686195, 5520.723963801875, 4865.0756356292195, 4931.975340123348, 4956.207006878882, 4973.50264973507, 5026.698398096126, 6047.78832740852, 6048.0625503047095, 6049.032154855202, 6059.818205453844, 6068.059450785136, 5700.657960522382, 5822.0, 5823.242978412779, 5824.068149096124, 5827.1841942127285, 5950.137230101697, 5970.373110823301, 6020.307664618625, 6022.2171117754415, 6031.819045428644, 5679.233303503974, 5690.345610254708, 5718.79984200551, 5719.599628025998, 5721.628094173865, 5834.18321434991, 5854.063349864001, 5858.7070646468355, 5886.941130588811, 5907.5273978080795, 5698.6580805151825, 5710.828675139753, 5713.914291285717, 5713.942860571341, 5715.742791574306, 5610.971945140248, 5641.746121424628, 5679.659220446786, 5697.715114244188, 5698.0, 5575.972120139373, 5701.287339082614, 5752.338481074563, 5788.421157884178, 5789.073748200268, 5635.915461268166, 5681.886362272814, 5719.056355701263, 5722.599418040863, 5737.139429085671, 5562.443755624405, 5597.63615365, 5613.859653508695, 5622.915656265078, 5641.464060914206], "value": 5363.948075206913, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.7728908436626, 594.0851089322443, 625.8967270400384, 631.8546734251122, 636.1793286660209, 43290.78354608227, 46130.0, 46276.30585541215, 49813.50186498134, 49849.0, 47194.0, 47590.52409475913, 47631.28553071698, 47661.76169119158, 47779.54976078228, 8698.739037828875, 9075.500847453404, 9267.351285410025, 9283.93234777999, 9301.581428835685, 8242.0, 10922.726931826688, 11091.778164436706, 11204.327740335566, 11507.079433645331, 11103.167262455348, 11148.05241554469, 11162.330260184415, 11169.441527923613, 11175.0, 11139.053180479668, 11206.943965280121, 11209.159313051554, 11211.047060999825, 11215.551377944872, 11029.503672334764, 11099.167562432849, 11103.83344249837, 11105.72235694106, 11109.611163609236, 44732.77633611843, 44955.550444495464, 44977.77511112456, 44988.0, 45022.774886125684, 4246.851360202409, 4289.613934745857, 4300.35494675798, 4320.395144679747, 4398.6700997425005, 31798.523022154684, 32271.838640806647, 32308.838455807807, 32616.347673046643, 32664.346713065606, 4126.958730412687, 4221.050263690676, 4228.238916994939, 4229.767362795045, 4361.214981303364, 297265.0, 298126.0, 299561.0, 299949.0, 300122.49938750383, 57327.14009289864, 57379.0, 57495.425045749005, 57535.0, 57596.712016440484, 64840.67579662166, 65240.0, 65296.673516632116, 65323.34676653173, 65383.67308163429, 17258.741118883227, 17463.476095716895, 17472.301107955795, 17476.126193690263, 17482.912585436992, 12546.874531254753, 12846.550370736979, 13184.340782961006, 13522.93238533801, 13603.795943060863, 17539.912300438416, 17558.0, 17634.294628214986, 17710.0, 17773.644527109387, 6682.699278532477, 6729.192496900403, 6834.521583489108, 6939.93060069403, 7042.753503627348, 878.446578655443, 903.620479398641, 918.2653876898454, 925.4077390470104, 962.7352478068448, 30247.546286805275, 31395.37209255802, 31442.685573144434, 31559.684403156134, 31664.208394790316, 1012.1346248957183, 1038.231708535678, 1043.7860238651058, 1054.3515737821338, 1071.9732006699894, 16526.256318465697, 16692.165391730367, 16825.747613785803, 16957.83042169587, 16995.660086798194, 449880.0, 451030.0, 451156.0, 452382.0, 453701.0, 62897.685511573065, 63228.36771632317, 63293.0, 63295.0, 63327.36672633307, 1409.5348534983432, 1459.3432955170215, 1464.0629996802056, 1467.662437639349, 1475.6163397516723, 29187.562186566793, 30131.213676579748, 30602.540961886036, 30778.692213078477, 30852.22869428282, 52492.737536312074, 53151.0, 53170.468295316554, 53285.0, 53297.4670253308, 289140.0, 290231.0, 290310.0, 290477.0, 290488.0, 39560.40659390169, 40509.0, 40509.0, 40765.38851917164, 40962.385564217155, 45216.54783452255, 45916.77041614771, 45992.31011534896, 46324.53675463337, 46688.0, 35426.0, 37047.444288336235, 37898.24203515859, 38178.80910595429, 38250.617493824706, 36556.0, 36956.63043369532, 37228.6277137236, 37410.43884341791, 37506.62493375031, 36500.269994599425, 36820.63179368279, 37170.25659486849, 37308.81345593255, 38137.0, 31197.220069497536, 32233.838830805696, 32424.513632296006, 32815.67184328126, 32975.34049318952, 24601.384965376008, 24763.13329033475, 24831.751682482944, 24934.875325623256, 25210.74789252084], "value": 20283.172926839456, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.0, 433.0991537601788, 438.9312025218593, 440.0999955091837, 446.47306212752386, 16611.252493637785, 20373.796262037395, 20552.794472055273, 21045.473863153427, 21723.456913577167, 21589.67615485769, 21609.67585486215, 21655.67516487254, 21766.782332176674, 21969.560608787815, 4797.568218860293, 5971.85070373242, 5995.070764031582, 5998.97000514999, 6030.306514750816, 5960.0761881908375, 5963.582549221556, 6049.425304596057, 6060.636361818283, 6061.484773794233, 6173.0, 6305.432511074003, 6324.3043265240785, 6325.936740632581, 6344.587601805891, 6074.848128796793, 6167.629942203437, 6228.875422491525, 6314.905276420857, 6321.968390158066, 6107.4808641265545, 6112.327643959161, 6112.63324200545, 6114.327423983358, 6115.143879856779, 14094.50669226572, 14117.152970821784, 14276.643083922985, 14336.856631433657, 14347.497837575635, 2654.495645827287, 2739.5890616407696, 2774.403503246812, 2802.2153796936686, 2824.2798086487815, 10610.151187904949, 10943.781124377547, 10947.4526273686, 10962.451877406178, 11182.105431565536, 1920.9039548022542, 1954.0264333023606, 1974.0, 1980.6137803128395, 1993.9302124425576, 67812.0, 69580.6520967397, 87167.0, 89974.0, 95718.9999999993, 11476.163813789753, 11783.705407364712, 11829.171957963032, 12064.605758947771, 12077.396130193456, 16857.072860992765, 16865.0, 16903.492895213163, 16915.23881425339, 16928.0, 8571.871421928676, 8703.129687031373, 8797.516136612549, 8975.37172397939, 9038.774030649154, 8289.502629842229, 8365.874511882326, 8423.749692042375, 8599.914000860037, 8643.956780216184, 5123.357595235821, 5181.5077567631015, 5248.816291429858, 5252.1596544552685, 5327.3074500314715, 2098.4124445155076, 2178.8692678439343, 2184.8252139828774, 2199.175309259028, 2208.094681180708, 871.5119533061505, 894.1952242981368, 895.7178488776015, 896.4486840593119, 915.9542022898828, 18941.905290473736, 19901.502462438264, 20079.39761807148, 20113.597728045355, 20171.394858153984, 884.6240347852137, 897.699270744295, 903.5708038681705, 908.4367692030983, 912.5710915869531, 10480.371177729361, 11024.944875275572, 11035.944820275847, 11037.503312350964, 11050.668479945614, 577295.0, 583399.0, 586817.3295667643, 592294.0, 596346.0, 93216.0, 95135.52432237794, 106094.0, 108903.0, 109546.45226773975, 1047.2878442658912, 1081.5295346524445, 1100.2298391126244, 1107.0258172807878, 1109.295597295723, 17946.820531794514, 18174.909125454287, 18791.624167516846, 18893.244270229035, 18979.525511862314, 47053.764731176125, 47768.0, 47910.28134578054, 47956.5204347952, 48454.27318590153, 68130.0, 68461.3153868455, 68603.3139668617, 69159.0, 69441.65279173572, 8399.41204115706, 8496.0, 8504.22434651539, 8751.0, 8830.602622882114, 9365.906340936775, 12794.488220471078, 13073.15024523403, 13249.80125298102, 13819.930900345435, 11452.198346115692, 11493.885061149282, 11609.535618575163, 11967.76064478723, 12114.93942530317, 11099.334039957628, 11244.156688248251, 11287.774244515227, 11335.376554289593, 11495.252808567417, 10954.39750813681, 11112.0, 11668.533258669559, 12049.939750301543, 12609.180403273758, 8773.473591584525, 8824.3381746368, 8860.424072435271, 8900.643974240958, 9056.456612603002, 10413.073581387467, 11327.433628318386, 11981.041516678819, 12069.456874440846, 12216.938915305367], "value": 9588.08756847116, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.277178937479, 1338.9263590502524, 1348.5347555093495, 1354.3228385807097, 1356.9728605427892, 8191.344692424606, 8639.740807775761, 8651.826963460728, 8663.870041949376, 8664.436811607242, 7637.809054773619, 7853.646585903633, 8180.181981801817, 8371.330293576515, 8403.495790252573, 2347.5539647467012, 2371.490129622131, 2372.8694921779297, 2375.9406014849596, 2377.821663375245, 2349.8472599281076, 2380.702412198475, 2383.8808059597036, 2390.95993242939, 2392.091005417939, 2016.9394918152404, 2078.064870808135, 2263.7283525976904, 2327.3367090379247, 2337.345543247885, 2321.6749655048307, 2325.6278995360663, 2328.324785812121, 2329.860208387502, 2333.7666233376694, 2231.497912969569, 2280.669302951063, 2298.643710224918, 2302.5394921015863, 2303.6890019847274, 8613.956930215372, 8674.783130421727, 8684.2618377438, 8685.08806575313, 8699.52152631605, 5260.631755777097, 5394.703291318976, 5415.512603865632, 5427.348718153808, 5434.701091439969, 3263.2657652028342, 3327.434336162858, 3390.7117894978956, 3396.218869659992, 3424.6917777400154, 1284.492625412966, 1369.6438925879243, 1377.1943413103347, 1409.0418515409517, 1456.4028748213182, 11593.24643898144, 11645.18483706141, 11672.0, 11685.649430517013, 11734.999999999915, 4345.152695224401, 4719.339292499053, 4779.354787103766, 4827.106985207678, 4829.782659780319, 10056.346337488187, 10101.040401161878, 10104.797904041878, 10128.240381971382, 10129.848052279222, 5516.558675305966, 5522.91715624266, 5525.0, 5525.972370138204, 5527.447255274521, 4342.6308763754805, 4474.6420286377015, 4959.429665588431, 5038.143515602356, 5048.747562621854, 4007.499062617173, 4019.8593049243723, 4066.5933406659688, 4075.144219713893, 4125.29869922114, 1314.3953781260536, 1321.662975941129, 1321.9537316193887, 1321.9867801322057, 1346.077936613423, 1003.7641154328727, 1013.1742629756725, 1018.7554986803262, 1025.3027941000191, 1029.5727273181697, 5833.591648584558, 5918.319393269743, 5944.494717948936, 5995.0, 6155.446009859134, 626.223482881224, 628.3433811666819, 637.7098420218789, 651.7197605029883, 652.5073569455031, 3847.1343947611563, 3935.626115519021, 4020.19596080785, 4086.3053280941717, 4086.7547947123267, 10016.49917504122, 10354.17166626668, 10354.948225258826, 10365.481725913674, 10381.11760500366, 10215.0, 10261.12688447236, 10302.587896484056, 10312.587496500206, 10357.223208259411, 7879.409044321699, 8027.959860200662, 8125.1062383137805, 8127.268545830785, 8141.267285944294, 5744.310682717934, 5847.356790752929, 5856.267966504187, 5897.351291357862, 6032.276126864805, 9469.431834089977, 9498.525073746147, 9499.762505937408, 9501.239900808057, 9597.136257736836, 8762.123787621187, 8918.063603321558, 9029.41308814925, 9227.123423274777, 9614.71155865325, 6730.966345168243, 6901.482388820758, 7211.38703210212, 7321.853562928818, 7496.700131994659, 7866.8819967701675, 8209.179082091743, 8212.260896519341, 8217.83564328698, 8223.876641850497, 7170.390516805921, 7301.452391070798, 7301.598412087386, 7465.7386991457215, 7535.585542795199, 7128.750493732695, 7326.597037163007, 7391.1500177480275, 7403.111626604842, 7515.586642734484, 6622.768203113061, 6738.124043874265, 6738.225104113089, 6742.5280230383405, 6744.156980377453, 5035.446100928822, 5060.468650791761, 5108.61685373591, 5125.974370128126, 5354.0, 5135.974320128375, 5264.2630031794815, 5280.788768449219, 5283.0, 5359.276497672764], "value": 4526.345698549313, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.32390416687167, 411.3336395040035, 424.10513815848554, 424.78511457232327, 432.36010704157866, 5269.499397557231, 5315.096433606286, 5316.441773613768, 5318.46815318468, 5320.228566857808, 5027.673201241917, 5041.470645582216, 5142.640015198937, 5184.7407629618465, 5204.817831375903, 4188.706790524657, 4209.957900420987, 4212.705110642256, 4224.366345048252, 4238.957610423902, 4231.936520952188, 4245.193413251488, 4256.191323648497, 4263.126059157865, 4266.871993840175, 4087.4481944937497, 4175.269327867626, 4214.620684138427, 4225.19721252961, 4226.415094339623, 4193.748375097473, 4205.600467955539, 4220.725652832587, 4223.873283801491, 4231.894202644928, 3836.462895194675, 3863.208042351311, 3869.1755018836407, 3882.301185786557, 3888.2806680764147, 5019.372578427697, 5062.788701506816, 5113.897722045575, 5160.896782064376, 5199.558037566773, 4903.828366007208, 4907.386576677915, 4913.950860491385, 4942.678725882806, 4949.317232141089, 5504.6421982571, 5517.144842549411, 5596.3284405871145, 5597.552195824324, 5630.690312032836, 4194.224068547298, 4286.485621725413, 4304.849330273425, 4318.676099292566, 4326.286162783137, 5509.696966666832, 5618.550515958755, 5765.827025189251, 5771.711414429262, 5779.508741756956, 4264.6801489888385, 4351.4995775485595, 4373.278409062533, 4373.572667169751, 4396.428464299621, 4433.490148632948, 4456.888577785517, 4457.264551349056, 4464.330350447394, 4467.45872673927, 4632.189366860786, 4739.265413860857, 4744.3595114659765, 4763.976180119077, 4775.95224047762, 5509.201165831012, 5539.556835453154, 5539.833804985857, 5541.972290138524, 5557.861053473695, 1445.4579532675248, 1466.8313143988364, 1488.3600051977753, 1489.9478518252026, 1499.482678475924, 1074.6399956014823, 1076.8692872484016, 1082.626493859617, 1092.306385445248, 1093.6937657455926, 5111.642185047085, 5132.845109850254, 5156.510131537498, 5200.933808569234, 5201.687898726089, 5505.43095217861, 5506.238003838813, 5515.420880807537, 5585.41995563642, 5603.495685388335, 5075.720835354017, 5313.990341835039, 5349.491798279158, 5356.785728570813, 5368.892622147613, 2880.1935458071775, 2890.7542858856814, 2901.564765285224, 2901.7243361880587, 2907.0232242075167, 5569.972150139223, 5709.714514274269, 5732.627379220337, 5732.742026608729, 5889.4993925515955, 5741.478508195331, 5809.24479817621, 5813.273340832396, 5819.53443724501, 5820.185174075633, 5781.971090144522, 5785.421457854265, 5827.0, 5832.650040997469, 5866.445391971217, 5515.972420137874, 5565.38603804892, 5611.607187496836, 5636.661800291996, 5650.971745141248, 5529.336479622471, 5564.165375193753, 5589.860253493695, 5592.552595792408, 5612.803551875828, 5600.751564092898, 5712.915025885975, 5720.799772007959, 5755.7122143893475, 5865.73604187804, 4071.328230841878, 4077.082656402286, 4100.876973690794, 4119.9382009270485, 4121.402396652408, 5498.120300751861, 5639.182318563868, 5670.659760414388, 5671.97904377216, 5677.864427114511, 5433.8369848904595, 5446.782128714965, 5452.537638599439, 5457.317835270591, 5511.972440137934, 5437.8368648940595, 5477.466309433365, 5497.47773961473, 5507.531859791962, 5512.614117011771, 5236.450172731808, 5443.401225865073, 5445.264889239902, 5453.427390123979, 5482.451754824486, 5501.339839219159, 5507.201455788808, 5507.614466987273, 5512.649400896806, 5514.724263786715, 5368.758405871823, 5378.332716857786, 5384.488473595002, 5385.8114965976, 5389.730513474389], "value": 4303.1768357004685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.0800223727058, 774.3263360876039, 789.9684012639494, 850.753281548351, 852.6684443029409, 14808.851911480882, 15152.54542363728, 15301.770473442893, 15308.846911530882, 15312.846871531296, 14697.559073227794, 14797.3341199646, 14886.25568721565, 15479.690406191869, 15737.763933540977, 748.1844789179793, 763.6754379388765, 768.5926458976751, 768.6502641298224, 770.3721467004401, 642.8328634555025, 662.5726406467826, 749.8800191969286, 751.5340488896892, 751.7368920877703, 777.2693667952107, 796.2157275084038, 802.5706247157772, 806.8063664720454, 807.3137832842067, 799.6561478564245, 800.0119851982796, 800.0559339978822, 800.3117319105564, 800.5997001499279, 499.459168465285, 502.60043265603935, 583.1748076471787, 584.1208980484344, 584.1792281844016, 15048.623784405368, 15528.767068493982, 15564.299606517734, 16042.197890105448, 16148.59628509285, 15510.14694191819, 15640.374385024585, 15685.0, 16059.116748578823, 16463.83536164635, 12449.564265250763, 12595.811062834066, 12727.0, 12838.422270997735, 12877.871221287762, 3710.962890371116, 3737.458068580068, 3774.6225377462033, 3821.522309711286, 3950.5654378018394, 75072.24927750653, 76046.0, 76242.99999999945, 78163.60918195429, 78273.0, 10754.892451075546, 10833.512491937881, 10836.566537338576, 10924.071453926505, 11076.5569377224, 23151.421214469436, 23277.767222327897, 23375.649365259535, 23390.0, 23711.288661340186, 8171.673133074611, 8215.301699355503, 8275.668973241123, 8425.789355266168, 8640.827183456297, 4334.718243314174, 4385.561443855653, 4416.690831641754, 4459.2865141577195, 4562.703424277412, 3647.325244829715, 3720.1815600567834, 3733.1973625670066, 3733.738638295293, 3737.9439308410397, 573.5153795043182, 573.7590212110923, 573.985650358736, 591.5474661883662, 601.2724603230054, 780.9609519524001, 795.0777098565636, 808.7302934393064, 812.6830536090929, 828.2628460669888, 9670.419774813534, 10287.889507827429, 10327.638532651321, 10864.239503234856, 10875.401852898167, 726.7948347786237, 753.1903204055662, 781.1641543548349, 782.5695867272977, 818.2472125644422, 5015.24771284303, 5058.215976523645, 5073.847784566469, 5124.180131178993, 5127.53852153308, 60511.69744151339, 67987.3201267991, 75876.62061689656, 76937.0, 78860.60569697115, 67612.32387676158, 68227.65886170538, 68513.0, 68547.65726171338, 68620.31379686139, 59989.40010599925, 60797.0, 61113.0, 61213.693931530055, 61510.0, 9663.226941844776, 9720.805583888141, 9838.0, 9882.85175722379, 9884.406935583887, 42558.78720606501, 42765.0, 43603.56396435995, 43705.34441983309, 44384.55615443804, 52698.736506317226, 53828.0, 54039.72980135074, 54085.18872216841, 54480.455195449125, 12449.564265250672, 12454.813177802522, 12615.810762838748, 12699.428525716181, 12769.8084528734, 13197.934010329887, 13626.523071692443, 13716.862831371558, 13894.374753135931, 14094.71086107168, 12477.0, 12799.168054076456, 13008.414621342252, 13137.080404371602, 13577.660558486117, 11951.94024029909, 12137.757244855231, 12162.087843411957, 12305.138640295452, 12318.384080796104, 11157.0, 11663.59177428786, 11689.707757306136, 11692.0, 11858.822117668069, 10496.947515262375, 10569.418681972566, 10686.465676716289, 10739.355638661706, 10801.405922674328, 10123.949380253052, 10188.235882308709, 10212.744681383025, 10330.690079297634, 10386.896131038593], "value": 7133.258388338816, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1507.1999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 113.0, 113.0, 111.0, 111.0, 112.0, 110.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 120.0, 126.0, 159.0, 124.0, 125.0, 124.0, 118.0, 136.0, 119.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 162.0, 162.0, 162.0, 164.0, 163.0, 161.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 104.0, 77.0, 77.0, 75.0, 75.0, 93.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 102.0, 84.0, 82.0, 83.0, 105.0, 85.0, 82.0, 106.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 146.0, 146.0, 148.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 55.0, 55.0, 56.0, 55.0, 57.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 82.0, 81.0, 87.0, 81.0, 83.0, 88.0, 80.0, 81.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 126.0, 124.0, 123.0, 125.0, 130.0, 128.0, 169.0, 152.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 176.0, 175.0, 171.0, 167.0, 170.0, 171.0, 173.0, 169.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 62.5, "unit": "score"}]}]} 05:20:50 INFO - Return code: 0 05:20:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:20:50 ERROR - # TBPL SUCCESS # 05:20:50 INFO - Running post-action listener: _resource_record_post_action 05:20:50 INFO - [mozharness: 2017-01-31 13:20:50.088937Z] Finished run-tests step (success) 05:20:50 INFO - Running post-run listener: _resource_record_post_run 05:20:50 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 400932864; Read time: 0; Write time: 295552 05:20:50 INFO - TinderboxPrint: CPU usage
13.0% 05:20:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:20:50 INFO - TinderboxPrint: I/O write bytes / time
400,932,864 / 295,552 05:20:50 INFO - TinderboxPrint: CPU idle
8,301.4 (87.0%) 05:20:50 INFO - TinderboxPrint: CPU user
1,198.6 (12.6%) 05:20:50 INFO - TinderboxPrint: Swap in / out
0 / 0 05:20:50 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105881600; Read time: 0; Write time: 72852 05:20:50 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 295051264; Read time: 0; Write time: 222700 05:20:50 INFO - Running post-run listener: _upload_blobber_files 05:20:50 INFO - Blob upload gear active. 05:20:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:20:50 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 05:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:20:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:20:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:51 INFO - (blobuploader) - INFO - Done attempting. 05:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:20:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:52 INFO - (blobuploader) - INFO - Done attempting. 05:20:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:20:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:20:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:56 INFO - (blobuploader) - INFO - Done attempting. 05:20:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:20:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:20:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:56 INFO - (blobuploader) - INFO - Done attempting. 05:20:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:20:56 INFO - Return code: 0 05:20:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:20:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:20:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd7572792c64b904f217a0c6592ecd153f01b09af558b03c10a8c90545c35bae8eae771108b84499af1d3bbfce42a905f54d69ad7a58f6c26c5175086c22e0d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/565a188d8c1cd830c74e46eef40c7776317bce7ad1265188ea508dc5d17242d01769fa53c414ee0be6f160086d1bad6e0b7b5024a3df0f3b917442509a983060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a3c0cb0cd8eb51c467047a34125d3cd4c153b3fb789498105eac126db37cc4212413b4d086a29a7fac3b797097507df01593886bd63a1a3ad8963b331e5b19a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b7cb10e7078f2114c73b092150d732be53a378bb82c0f28032a26329fb15e1f01cf4a88fbc55fbf93b3a8126ad34873a469a4e360f0e95d5efa64cbbfc3ad81"} 05:20:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:20:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:20:56 INFO - Contents: 05:20:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd7572792c64b904f217a0c6592ecd153f01b09af558b03c10a8c90545c35bae8eae771108b84499af1d3bbfce42a905f54d69ad7a58f6c26c5175086c22e0d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/565a188d8c1cd830c74e46eef40c7776317bce7ad1265188ea508dc5d17242d01769fa53c414ee0be6f160086d1bad6e0b7b5024a3df0f3b917442509a983060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a3c0cb0cd8eb51c467047a34125d3cd4c153b3fb789498105eac126db37cc4212413b4d086a29a7fac3b797097507df01593886bd63a1a3ad8963b331e5b19a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b7cb10e7078f2114c73b092150d732be53a378bb82c0f28032a26329fb15e1f01cf4a88fbc55fbf93b3a8126ad34873a469a4e360f0e95d5efa64cbbfc3ad81"} 05:20:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:20:56 INFO - Copying logs to upload dir... 05:20:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:20:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.167085 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-31 05:20:56.324629) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 05:20:56.329640) ========= 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=836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283 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/sha512/cd7572792c64b904f217a0c6592ecd153f01b09af558b03c10a8c90545c35bae8eae771108b84499af1d3bbfce42a905f54d69ad7a58f6c26c5175086c22e0d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/565a188d8c1cd830c74e46eef40c7776317bce7ad1265188ea508dc5d17242d01769fa53c414ee0be6f160086d1bad6e0b7b5024a3df0f3b917442509a983060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a3c0cb0cd8eb51c467047a34125d3cd4c153b3fb789498105eac126db37cc4212413b4d086a29a7fac3b797097507df01593886bd63a1a3ad8963b331e5b19a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b7cb10e7078f2114c73b092150d732be53a378bb82c0f28032a26329fb15e1f01cf4a88fbc55fbf93b3a8126ad34873a469a4e360f0e95d5efa64cbbfc3ad81"} build_url:https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/Fd1wDynYTdS4hgZvPX30iQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd7572792c64b904f217a0c6592ecd153f01b09af558b03c10a8c90545c35bae8eae771108b84499af1d3bbfce42a905f54d69ad7a58f6c26c5175086c22e0d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/565a188d8c1cd830c74e46eef40c7776317bce7ad1265188ea508dc5d17242d01769fa53c414ee0be6f160086d1bad6e0b7b5024a3df0f3b917442509a983060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a3c0cb0cd8eb51c467047a34125d3cd4c153b3fb789498105eac126db37cc4212413b4d086a29a7fac3b797097507df01593886bd63a1a3ad8963b331e5b19a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b7cb10e7078f2114c73b092150d732be53a378bb82c0f28032a26329fb15e1f01cf4a88fbc55fbf93b3a8126ad34873a469a4e360f0e95d5efa64cbbfc3ad81"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 05:20:56.362388) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 05:20:56.362739) ========= 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=836cfdc75598d54cb747368e000001a9-1485866755.879805-1183492283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 05:20:56.446637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 05:20:56.446996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 05:20:56.447345) ========= ========= Total master_lag: 0.19 =========