builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1471877508.31 results: success (0) buildid: 20160822063914 builduid: ac95ec65533e440cb6a32a4a9fd69779 revision: 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:48.313212) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:48.313952) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:48.314242) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:48.336326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:48.336585) ========= 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=1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 07:51:48-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-08-22 07:51:48 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107479 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:48.470776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:48.471182) ========= 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=1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022463 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:48.527950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:48.528386) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 --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=1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 07:51:49,062 truncating revision to first 12 chars 2016-08-22 07:51:49,062 Setting DEBUG logging. 2016-08-22 07:51:49,062 attempt 1/10 2016-08-22 07:51:49,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f3d66a9ea5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 07:51:49,339 unpacking tar archive at: mozilla-central-5f3d66a9ea5d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569243 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:49.112611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:49.112919) ========= script_repo_revision: 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:49.113269) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:49.113528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 07:51:49.122441) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-22 07:51:49.122730) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:51:49 INFO - MultiFileLogger online at 20160822 07:51:49 in /builds/slave/test 07:51:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:51:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:51:49 INFO - {'append_to_log': False, 07:51:49 INFO - 'base_work_dir': '/builds/slave/test', 07:51:49 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:51:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:51:49 INFO - 'branch': 'Firefox-Non-PGO', 07:51:49 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:49 INFO - 'config_files': ('talos/linux_config.py',), 07:51:49 INFO - 'default_actions': ('clobber', 07:51:49 INFO - 'read-buildbot-config', 07:51:49 INFO - 'download-and-extract', 07:51:49 INFO - 'populate-webroot', 07:51:49 INFO - 'create-virtualenv', 07:51:49 INFO - 'install', 07:51:49 INFO - 'run-tests'), 07:51:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:49 INFO - 'download_minidump_stackwalk': True, 07:51:49 INFO - 'download_symbols': 'ondemand', 07:51:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:49 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:49 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:49 INFO - 'installer_path': 'installer.exe', 07:51:49 INFO - 'log_level': 'info', 07:51:49 INFO - 'log_name': 'talos', 07:51:49 INFO - 'log_to_console': True, 07:51:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:51:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:51:49 INFO - 'opt_config_files': (), 07:51:49 INFO - 'pip_index': False, 07:51:49 INFO - 'sps_profile': False, 07:51:49 INFO - 'sps_profile_interval': 0, 07:51:49 INFO - 'suite': 'dromaeojs', 07:51:49 INFO - 'system_bits': '32', 07:51:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:49 INFO - 'title': 'talos-linux64-ix-027', 07:51:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:49 INFO - 'use_talos_json': True, 07:51:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:51:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:49 INFO - 'work_dir': 'build'} 07:51:49 INFO - [mozharness: 2016-08-22 14:51:49.742990Z] Running clobber step. 07:51:49 INFO - Running pre-action listener: _resource_record_pre_action 07:51:49 INFO - Running main action method: clobber 07:51:49 INFO - rmtree: /builds/slave/test/build 07:51:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:51:50 INFO - Running post-action listener: _resource_record_post_action 07:51:50 INFO - [mozharness: 2016-08-22 14:51:50.201261Z] Finished clobber step (success) 07:51:50 INFO - [mozharness: 2016-08-22 14:51:50.201364Z] Running read-buildbot-config step. 07:51:50 INFO - Running pre-action listener: _resource_record_pre_action 07:51:50 INFO - Running main action method: read_buildbot_config 07:51:50 INFO - Using buildbot properties: 07:51:50 INFO - { 07:51:50 INFO - "project": "", 07:51:50 INFO - "product": "firefox", 07:51:50 INFO - "script_repo_revision": "production", 07:51:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:51:50 INFO - "repository": "", 07:51:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:51:50 INFO - "buildid": "20160822063914", 07:51:50 INFO - "pgo_build": "False", 07:51:50 INFO - "basedir": "/builds/slave/test", 07:51:50 INFO - "buildnumber": 688, 07:51:50 INFO - "slavename": "talos-linux64-ix-027", 07:51:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:51:50 INFO - "platform": "ubuntu64_hw", 07:51:50 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:51:50 INFO - "branch": "mozilla-central", 07:51:50 INFO - "repo_path": "mozilla-central", 07:51:50 INFO - "revision": "5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4", 07:51:50 INFO - "stage_platform": "linux64", 07:51:50 INFO - "builduid": "ac95ec65533e440cb6a32a4a9fd69779", 07:51:50 INFO - "slavebuilddir": "test" 07:51:50 INFO - } 07:51:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:51:50 INFO - Running post-action listener: _resource_record_post_action 07:51:50 INFO - [mozharness: 2016-08-22 14:51:50.203790Z] Finished read-buildbot-config step (success) 07:51:50 INFO - [mozharness: 2016-08-22 14:51:50.203878Z] Running download-and-extract step. 07:51:50 INFO - Running pre-action listener: _resource_record_pre_action 07:51:50 INFO - Running main action method: download_and_extract 07:51:50 INFO - mkdir: /builds/slave/test/build/tests 07:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:50 INFO - trying https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:51:50 INFO - Downloading https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:51:50 INFO - Downloaded 1361 bytes. 07:51:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:51:50 INFO - Using the following test package requirements: 07:51:50 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:50 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:51:50 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:51:50 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:50 INFO - u'jsshell-linux-x86_64.zip'], 07:51:50 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:51:50 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:50 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:51:50 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:51:50 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:51:50 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:51:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:50 INFO - trying https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:51:50 INFO - Downloading https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:51:51 INFO - Downloaded 20330094 bytes. 07:51:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:51:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:55 INFO - trying https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:51:55 INFO - Downloading https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:51:56 INFO - Downloaded 20330094 bytes. 07:51:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:01 INFO - trying https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:52:01 INFO - Downloading https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:52:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:52:02 INFO - Downloaded 14413981 bytes. 07:52:02 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 07:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:02 INFO - trying https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:52:02 INFO - Downloading https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:52:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:52:04 INFO - Downloaded 55760283 bytes. 07:52:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:52:04 INFO - mkdir: /builds/slave/test/properties 07:52:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:52:04 INFO - Writing to file /builds/slave/test/properties/build_url 07:52:04 INFO - Contents: 07:52:04 INFO - build_url:https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:52:04 INFO - Running post-action listener: _resource_record_post_action 07:52:04 INFO - Running post-action listener: set_extra_try_arguments 07:52:04 INFO - [mozharness: 2016-08-22 14:52:04.938285Z] Finished download-and-extract step (success) 07:52:04 INFO - [mozharness: 2016-08-22 14:52:04.938512Z] Running populate-webroot step. 07:52:04 INFO - Running pre-action listener: _resource_record_pre_action 07:52:04 INFO - Running main action method: populate_webroot 07:52:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:04 INFO - '--tppagecycles', 07:52:04 INFO - '7'], 07:52:04 INFO - 'tests': ['tsvgm']}}, 07:52:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:52:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:52:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:52:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:04 INFO - 'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:04 INFO - 'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['damp', 'tps']}, 07:52:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:04 INFO - 'tests': ['damp', 'tps']}, 07:52:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['dromaeo_dom']}, 07:52:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['basic_compositor_video']}, 07:52:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:52:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['a11yr', 07:52:04 INFO - 'ts_paint', 07:52:04 INFO - 'tpaint', 07:52:04 INFO - 'sessionrestore', 07:52:04 INFO - 'sessionrestore_no_auto_restore', 07:52:04 INFO - 'tabpaint']}, 07:52:04 INFO - 'other-e10s': {'tests': ['a11yr', 07:52:04 INFO - 'ts_paint', 07:52:04 INFO - 'tpaint', 07:52:04 INFO - 'sessionrestore', 07:52:04 INFO - 'sessionrestore_no_auto_restore', 07:52:04 INFO - 'tabpaint']}, 07:52:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:52:04 INFO - 'ts_paint', 07:52:04 INFO - 'tpaint', 07:52:04 INFO - 'sessionrestore', 07:52:04 INFO - 'sessionrestore_no_auto_restore', 07:52:04 INFO - 'tabpaint']}, 07:52:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:52:04 INFO - 'ts_paint', 07:52:04 INFO - 'tpaint', 07:52:04 INFO - 'sessionrestore', 07:52:04 INFO - 'sessionrestore_no_auto_restore', 07:52:04 INFO - 'tabpaint']}, 07:52:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['a11yr', 07:52:04 INFO - 'ts_paint', 07:52:04 INFO - 'tpaint', 07:52:04 INFO - 'sessionrestore', 07:52:04 INFO - 'sessionrestore_no_auto_restore', 07:52:04 INFO - 'tabpaint']}, 07:52:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['a11yr', 07:52:04 INFO - 'ts_paint', 07:52:04 INFO - 'tpaint', 07:52:04 INFO - 'sessionrestore', 07:52:04 INFO - 'sessionrestore_no_auto_restore', 07:52:04 INFO - 'tabpaint']}, 07:52:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['tsvgx', 07:52:04 INFO - 'tsvgr_opacity', 07:52:04 INFO - 'tart', 07:52:04 INFO - 'tscrollx', 07:52:04 INFO - 'cart']}, 07:52:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:52:04 INFO - 'tsvgr_opacity', 07:52:04 INFO - 'tart', 07:52:04 INFO - 'tscrollx', 07:52:04 INFO - 'cart']}, 07:52:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:04 INFO - 'talos_options': ['--disable-e10s'], 07:52:04 INFO - 'tests': ['tp5o']}, 07:52:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:04 INFO - 'tests': ['tp5o']}, 07:52:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:04 INFO - 'talos_options': ['--disable-e10s', 07:52:04 INFO - '--xperf_path', 07:52:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:04 INFO - 'tests': ['tp5n']}, 07:52:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:04 INFO - 'talos_options': ['--xperf_path', 07:52:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:04 INFO - 'tests': ['tp5n']}}, 07:52:04 INFO - 'talos.zip': {'path': '', 07:52:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:04 INFO - Running post-action listener: _resource_record_post_action 07:52:04 INFO - [mozharness: 2016-08-22 14:52:04.955921Z] Finished populate-webroot step (success) 07:52:04 INFO - [mozharness: 2016-08-22 14:52:04.956010Z] Running create-virtualenv step. 07:52:04 INFO - Running pre-action listener: _resource_record_pre_action 07:52:04 INFO - Running main action method: create_virtualenv 07:52:04 INFO - Creating virtualenv /builds/slave/test/build/venv 07:52:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:52:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:52:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:05 INFO - Using real prefix '/usr' 07:52:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:52:05 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:07 INFO - Installing pip.................done. 07:52:07 INFO - Return code: 0 07:52:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0204a85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, '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': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:52:07 INFO - Using env: {'DISPLAY': ':0', 07:52:07 INFO - 'HOME': '/home/cltbld', 07:52:07 INFO - 'LANG': 'en_US.UTF-8', 07:52:07 INFO - 'LANGUAGE': 'en_US:en', 07:52:07 INFO - 'LOGNAME': 'cltbld', 07:52:07 INFO - 'MAIL': '/var/mail/cltbld', 07:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:07 INFO - 'MOZ_NO_REMOTE': '1', 07:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:07 INFO - 'NO_EM_RESTART': '1', 07:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:07 INFO - 'PWD': '/builds/slave/test', 07:52:07 INFO - 'SHELL': '/bin/bash', 07:52:07 INFO - 'SHLVL': '1', 07:52:07 INFO - 'TERM': 'linux', 07:52:07 INFO - 'TMOUT': '86400', 07:52:07 INFO - 'USER': 'cltbld', 07:52:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:07 INFO - '_': '/tools/buildbot/bin/python'} 07:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:52:07 INFO - Cleaning up... 07:52:07 INFO - Return code: 0 07:52:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0204a85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, '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': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:52:07 INFO - Using env: {'DISPLAY': ':0', 07:52:07 INFO - 'HOME': '/home/cltbld', 07:52:07 INFO - 'LANG': 'en_US.UTF-8', 07:52:07 INFO - 'LANGUAGE': 'en_US:en', 07:52:07 INFO - 'LOGNAME': 'cltbld', 07:52:07 INFO - 'MAIL': '/var/mail/cltbld', 07:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:07 INFO - 'MOZ_NO_REMOTE': '1', 07:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:07 INFO - 'NO_EM_RESTART': '1', 07:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:07 INFO - 'PWD': '/builds/slave/test', 07:52:07 INFO - 'SHELL': '/bin/bash', 07:52:07 INFO - 'SHLVL': '1', 07:52:07 INFO - 'TERM': 'linux', 07:52:07 INFO - 'TMOUT': '86400', 07:52:07 INFO - 'USER': 'cltbld', 07:52:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:07 INFO - '_': '/tools/buildbot/bin/python'} 07:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:07 INFO - Downloading/unpacking psutil>=3.1.1 07:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:52:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:09 INFO - Installing collected packages: psutil 07:52:09 INFO - Running setup.py install for psutil 07:52:10 INFO - building 'psutil._psutil_linux' extension 07:52:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:52:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:52:10 INFO - building 'psutil._psutil_posix' extension 07:52:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:52:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:52:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:10 INFO - Successfully installed psutil 07:52:10 INFO - Cleaning up... 07:52:10 INFO - Return code: 0 07:52:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:10 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 0x7f0204a85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, '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': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:52:10 INFO - Using env: {'DISPLAY': ':0', 07:52:10 INFO - 'HOME': '/home/cltbld', 07:52:10 INFO - 'LANG': 'en_US.UTF-8', 07:52:10 INFO - 'LANGUAGE': 'en_US:en', 07:52:10 INFO - 'LOGNAME': 'cltbld', 07:52:10 INFO - 'MAIL': '/var/mail/cltbld', 07:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:10 INFO - 'MOZ_NO_REMOTE': '1', 07:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:10 INFO - 'NO_EM_RESTART': '1', 07:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:10 INFO - 'PWD': '/builds/slave/test', 07:52:10 INFO - 'SHELL': '/bin/bash', 07:52:10 INFO - 'SHLVL': '1', 07:52:10 INFO - 'TERM': 'linux', 07:52:10 INFO - 'TMOUT': '86400', 07:52:10 INFO - 'USER': 'cltbld', 07:52:10 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:10 INFO - '_': '/tools/buildbot/bin/python'} 07:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:52:12 INFO - Installing collected packages: mozsystemmonitor 07:52:12 INFO - Running setup.py install for mozsystemmonitor 07:52:12 INFO - Successfully installed mozsystemmonitor 07:52:12 INFO - Cleaning up... 07:52:12 INFO - Return code: 0 07:52:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0204a85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, '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': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:52:12 INFO - Using env: {'DISPLAY': ':0', 07:52:12 INFO - 'HOME': '/home/cltbld', 07:52:12 INFO - 'LANG': 'en_US.UTF-8', 07:52:12 INFO - 'LANGUAGE': 'en_US:en', 07:52:12 INFO - 'LOGNAME': 'cltbld', 07:52:12 INFO - 'MAIL': '/var/mail/cltbld', 07:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:12 INFO - 'MOZ_NO_REMOTE': '1', 07:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:12 INFO - 'NO_EM_RESTART': '1', 07:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:12 INFO - 'PWD': '/builds/slave/test', 07:52:12 INFO - 'SHELL': '/bin/bash', 07:52:12 INFO - 'SHLVL': '1', 07:52:12 INFO - 'TERM': 'linux', 07:52:12 INFO - 'TMOUT': '86400', 07:52:12 INFO - 'USER': 'cltbld', 07:52:12 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:12 INFO - '_': '/tools/buildbot/bin/python'} 07:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:13 INFO - Downloading/unpacking jsonschema==2.5.1 07:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:15 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:15 INFO - warning: no files found matching '*.txt' 07:52:15 INFO - no previously-included directories found matching 'build' 07:52:15 INFO - no previously-included directories found matching 'dist' 07:52:15 INFO - no previously-included directories found matching '.git*' 07:52:15 INFO - Installing collected packages: jsonschema, functools32 07:52:15 INFO - Running setup.py install for functools32 07:52:15 INFO - warning: no files found matching '*.txt' 07:52:15 INFO - no previously-included directories found matching 'build' 07:52:15 INFO - no previously-included directories found matching 'dist' 07:52:15 INFO - no previously-included directories found matching '.git*' 07:52:15 INFO - Successfully installed jsonschema functools32 07:52:15 INFO - Cleaning up... 07:52:15 INFO - Return code: 0 07:52:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:15 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 0x7f0204a85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, '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': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:52:15 INFO - Using env: {'DISPLAY': ':0', 07:52:15 INFO - 'HOME': '/home/cltbld', 07:52:15 INFO - 'LANG': 'en_US.UTF-8', 07:52:15 INFO - 'LANGUAGE': 'en_US:en', 07:52:15 INFO - 'LOGNAME': 'cltbld', 07:52:15 INFO - 'MAIL': '/var/mail/cltbld', 07:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:15 INFO - 'MOZ_NO_REMOTE': '1', 07:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:15 INFO - 'NO_EM_RESTART': '1', 07:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:15 INFO - 'PWD': '/builds/slave/test', 07:52:15 INFO - 'SHELL': '/bin/bash', 07:52:15 INFO - 'SHLVL': '1', 07:52:15 INFO - 'TERM': 'linux', 07:52:15 INFO - 'TMOUT': '86400', 07:52:15 INFO - 'USER': 'cltbld', 07:52:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:15 INFO - '_': '/tools/buildbot/bin/python'} 07:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:52:15 INFO - Cleaning up... 07:52:15 INFO - Return code: 0 07:52:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:15 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 0x7f0204a85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, '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': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:52:15 INFO - Using env: {'DISPLAY': ':0', 07:52:15 INFO - 'HOME': '/home/cltbld', 07:52:15 INFO - 'LANG': 'en_US.UTF-8', 07:52:15 INFO - 'LANGUAGE': 'en_US:en', 07:52:15 INFO - 'LOGNAME': 'cltbld', 07:52:15 INFO - 'MAIL': '/var/mail/cltbld', 07:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:15 INFO - 'MOZ_NO_REMOTE': '1', 07:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:15 INFO - 'NO_EM_RESTART': '1', 07:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:15 INFO - 'PWD': '/builds/slave/test', 07:52:15 INFO - 'SHELL': '/bin/bash', 07:52:15 INFO - 'SHLVL': '1', 07:52:15 INFO - 'TERM': 'linux', 07:52:15 INFO - 'TMOUT': '86400', 07:52:15 INFO - 'USER': 'cltbld', 07:52:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:15 INFO - '_': '/tools/buildbot/bin/python'} 07:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:15 INFO - Downloading/unpacking blobuploader==1.2.4 07:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:17 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:52:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:18 INFO - Downloading docopt-0.6.1.tar.gz 07:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:18 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:18 INFO - Running setup.py install for blobuploader 07:52:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:52:18 INFO - Running setup.py install for requests 07:52:18 INFO - Running setup.py install for docopt 07:52:19 INFO - Successfully installed blobuploader requests docopt 07:52:19 INFO - Cleaning up... 07:52:19 INFO - Return code: 0 07:52:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:19 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 0x7f0204a85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, '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': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:19 INFO - Using env: {'DISPLAY': ':0', 07:52:19 INFO - 'HOME': '/home/cltbld', 07:52:19 INFO - 'LANG': 'en_US.UTF-8', 07:52:19 INFO - 'LANGUAGE': 'en_US:en', 07:52:19 INFO - 'LOGNAME': 'cltbld', 07:52:19 INFO - 'MAIL': '/var/mail/cltbld', 07:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:19 INFO - 'MOZ_NO_REMOTE': '1', 07:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:19 INFO - 'NO_EM_RESTART': '1', 07:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:19 INFO - 'PWD': '/builds/slave/test', 07:52:19 INFO - 'SHELL': '/bin/bash', 07:52:19 INFO - 'SHLVL': '1', 07:52:19 INFO - 'TERM': 'linux', 07:52:19 INFO - 'TMOUT': '86400', 07:52:19 INFO - 'USER': 'cltbld', 07:52:19 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:19 INFO - '_': '/tools/buildbot/bin/python'} 07:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:19 INFO - Running setup.py (path:/tmp/pip-qtxA9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:19 INFO - Running setup.py (path:/tmp/pip-LJDdfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:19 INFO - Running setup.py (path:/tmp/pip-Sj_ZAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:19 INFO - Running setup.py (path:/tmp/pip-62Xb9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:19 INFO - Running setup.py (path:/tmp/pip-UCNWPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:19 INFO - Running setup.py (path:/tmp/pip-XCD245-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:19 INFO - Running setup.py (path:/tmp/pip-6oIX_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:19 INFO - Running setup.py (path:/tmp/pip-SVFfEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:19 INFO - Running setup.py (path:/tmp/pip-cTpYqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:19 INFO - Running setup.py (path:/tmp/pip-RLWZRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:20 INFO - Running setup.py (path:/tmp/pip-cw2KNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:20 INFO - Running setup.py (path:/tmp/pip-48y1Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:20 INFO - Running setup.py (path:/tmp/pip-7Kf3f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:20 INFO - Running setup.py (path:/tmp/pip-av8v38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:20 INFO - Running setup.py (path:/tmp/pip-FI4FqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:20 INFO - Running setup.py (path:/tmp/pip-vtD_1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:20 INFO - Running setup.py (path:/tmp/pip-WXWyH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:20 INFO - Running setup.py install for manifestparser 07:52:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:52:20 INFO - Running setup.py install for mozcrash 07:52:20 INFO - Running setup.py install for mozdebug 07:52:20 INFO - Running setup.py install for mozdevice 07:52:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:52:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:52:20 INFO - Running setup.py install for mozfile 07:52:21 INFO - Running setup.py install for mozhttpd 07:52:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Running setup.py install for mozinfo 07:52:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Running setup.py install for mozInstall 07:52:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Running setup.py install for mozleak 07:52:21 INFO - Running setup.py install for mozlog 07:52:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Running setup.py install for moznetwork 07:52:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Running setup.py install for mozprocess 07:52:21 INFO - Running setup.py install for mozprofile 07:52:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:52:21 INFO - Running setup.py install for mozrunner 07:52:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:52:22 INFO - Running setup.py install for mozscreenshot 07:52:22 INFO - Running setup.py install for moztest 07:52:22 INFO - Running setup.py install for mozversion 07:52:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:52:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:22 INFO - Cleaning up... 07:52:22 INFO - Return code: 0 07:52:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:22 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 0x7f0204a85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, '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': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:22 INFO - Using env: {'DISPLAY': ':0', 07:52:22 INFO - 'HOME': '/home/cltbld', 07:52:22 INFO - 'LANG': 'en_US.UTF-8', 07:52:22 INFO - 'LANGUAGE': 'en_US:en', 07:52:22 INFO - 'LOGNAME': 'cltbld', 07:52:22 INFO - 'MAIL': '/var/mail/cltbld', 07:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:22 INFO - 'MOZ_NO_REMOTE': '1', 07:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:22 INFO - 'NO_EM_RESTART': '1', 07:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:22 INFO - 'PWD': '/builds/slave/test', 07:52:22 INFO - 'SHELL': '/bin/bash', 07:52:22 INFO - 'SHLVL': '1', 07:52:22 INFO - 'TERM': 'linux', 07:52:22 INFO - 'TMOUT': '86400', 07:52:22 INFO - 'USER': 'cltbld', 07:52:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:22 INFO - '_': '/tools/buildbot/bin/python'} 07:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:22 INFO - Running setup.py (path:/tmp/pip-FzsPEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:22 INFO - Running setup.py (path:/tmp/pip-7P0RCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:22 INFO - Running setup.py (path:/tmp/pip-ZhXdOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:22 INFO - Running setup.py (path:/tmp/pip-nLR_5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:22 INFO - Running setup.py (path:/tmp/pip-DOgOF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:22 INFO - Running setup.py (path:/tmp/pip-OzyKcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:22 INFO - Running setup.py (path:/tmp/pip-oXHjIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:23 INFO - Running setup.py (path:/tmp/pip-aQOVqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:23 INFO - Running setup.py (path:/tmp/pip-I5viPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:23 INFO - Running setup.py (path:/tmp/pip-dTfo2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:23 INFO - Running setup.py (path:/tmp/pip-SIBY4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:23 INFO - Running setup.py (path:/tmp/pip-j8pU_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:23 INFO - Running setup.py (path:/tmp/pip-94GC5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:23 INFO - Running setup.py (path:/tmp/pip-v8o7mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:23 INFO - Running setup.py (path:/tmp/pip-rOtgxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:23 INFO - Running setup.py (path:/tmp/pip-Q6U5uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:23 INFO - Running setup.py (path:/tmp/pip-vTBxuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:52:23 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:23 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:25 INFO - Downloading blessings-1.6.tar.gz 07:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:25 INFO - Installing collected packages: blessings 07:52:25 INFO - Running setup.py install for blessings 07:52:25 INFO - Successfully installed blessings 07:52:25 INFO - Cleaning up... 07:52:25 INFO - Return code: 0 07:52:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:52:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:26 INFO - Reading from file tmpfile_stdout 07:52:26 INFO - Current package versions: 07:52:26 INFO - argparse == 1.2.1 07:52:26 INFO - blessings == 1.6 07:52:26 INFO - blobuploader == 1.2.4 07:52:26 INFO - docopt == 0.6.1 07:52:26 INFO - functools32 == 3.2.3-2 07:52:26 INFO - jsonschema == 2.5.1 07:52:26 INFO - manifestparser == 1.1 07:52:26 INFO - mozInstall == 1.12 07:52:26 INFO - mozcrash == 0.17 07:52:26 INFO - mozdebug == 0.1 07:52:26 INFO - mozdevice == 0.48 07:52:26 INFO - mozfile == 1.2 07:52:26 INFO - mozhttpd == 0.7 07:52:26 INFO - mozinfo == 0.9 07:52:26 INFO - mozleak == 0.1 07:52:26 INFO - mozlog == 3.3 07:52:26 INFO - moznetwork == 0.27 07:52:26 INFO - mozprocess == 0.23 07:52:26 INFO - mozprofile == 0.28 07:52:26 INFO - mozrunner == 6.12 07:52:26 INFO - mozscreenshot == 0.1 07:52:26 INFO - mozsystemmonitor == 0.3 07:52:26 INFO - moztest == 0.7 07:52:26 INFO - mozversion == 1.4 07:52:26 INFO - psutil == 3.1.1 07:52:26 INFO - requests == 1.2.3 07:52:26 INFO - wsgiref == 0.1.2 07:52:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:26 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 0x7f0204a85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, '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': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:26 INFO - Using env: {'DISPLAY': ':0', 07:52:26 INFO - 'HOME': '/home/cltbld', 07:52:26 INFO - 'LANG': 'en_US.UTF-8', 07:52:26 INFO - 'LANGUAGE': 'en_US:en', 07:52:26 INFO - 'LOGNAME': 'cltbld', 07:52:26 INFO - 'MAIL': '/var/mail/cltbld', 07:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:26 INFO - 'MOZ_NO_REMOTE': '1', 07:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:26 INFO - 'NO_EM_RESTART': '1', 07:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:26 INFO - 'PWD': '/builds/slave/test', 07:52:26 INFO - 'SHELL': '/bin/bash', 07:52:26 INFO - 'SHLVL': '1', 07:52:26 INFO - 'TERM': 'linux', 07:52:26 INFO - 'TMOUT': '86400', 07:52:26 INFO - 'USER': 'cltbld', 07:52:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:26 INFO - '_': '/tools/buildbot/bin/python'} 07:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:52:26 INFO - Cleaning up... 07:52:26 INFO - Return code: 0 07:52:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0204a85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, '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': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:52:26 INFO - Using env: {'DISPLAY': ':0', 07:52:26 INFO - 'HOME': '/home/cltbld', 07:52:26 INFO - 'LANG': 'en_US.UTF-8', 07:52:26 INFO - 'LANGUAGE': 'en_US:en', 07:52:26 INFO - 'LOGNAME': 'cltbld', 07:52:26 INFO - 'MAIL': '/var/mail/cltbld', 07:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:26 INFO - 'MOZ_NO_REMOTE': '1', 07:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:26 INFO - 'NO_EM_RESTART': '1', 07:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:26 INFO - 'PWD': '/builds/slave/test', 07:52:26 INFO - 'SHELL': '/bin/bash', 07:52:26 INFO - 'SHLVL': '1', 07:52:26 INFO - 'TERM': 'linux', 07:52:26 INFO - 'TMOUT': '86400', 07:52:26 INFO - 'USER': 'cltbld', 07:52:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:26 INFO - '_': '/tools/buildbot/bin/python'} 07:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:52:26 INFO - Cleaning up... 07:52:26 INFO - Return code: 0 07:52:26 INFO - Running post-action listener: _resource_record_post_action 07:52:26 INFO - Running post-action listener: _start_resource_monitoring 07:52:26 INFO - Starting resource monitoring. 07:52:26 INFO - [mozharness: 2016-08-22 14:52:26.608573Z] Finished create-virtualenv step (success) 07:52:26 INFO - [mozharness: 2016-08-22 14:52:26.609116Z] Running install step. 07:52:26 INFO - Running pre-action listener: _resource_record_pre_action 07:52:26 INFO - Running main action method: install 07:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:26 INFO - Reading from file tmpfile_stdout 07:52:26 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:52:26 INFO - Reading from file tmpfile_stdout 07:52:26 INFO - Output received: 07:52:26 INFO - Usage: mozinstall [options] installer 07:52:26 INFO - Options: 07:52:26 INFO - -h, --help show this help message and exit 07:52:26 INFO - -d DEST, --destination=DEST 07:52:26 INFO - Directory to install application into. [default: 07:52:26 INFO - "/builds/slave/test"] 07:52:26 INFO - --app=APP Application being installed. [default: firefox] 07:52:26 INFO - mkdir: /builds/slave/test/build/application 07:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:52:43 INFO - Reading from file tmpfile_stdout 07:52:43 INFO - Output received: 07:52:43 INFO - /builds/slave/test/build/application/firefox/firefox 07:52:43 INFO - Running post-action listener: _resource_record_post_action 07:52:43 INFO - [mozharness: 2016-08-22 14:52:43.003219Z] Finished install step (success) 07:52:43 INFO - [mozharness: 2016-08-22 14:52:43.003467Z] Running run-tests step. 07:52:43 INFO - Running pre-action listener: _resource_record_pre_action 07:52:43 INFO - Running main action method: run_tests 07:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:52:43 INFO - Python 2.7.3 07:52:43 INFO - Return code: 0 07:52:43 INFO - grabbing minidump binary from tooltool 07:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:43 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 0x2496090>, '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 0x24999b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2499e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:52:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:52:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:52:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:52:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:52:43 INFO - Return code: 0 07:52:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:52:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:52:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:52:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:52:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:52:43 INFO - Using env: {'DISPLAY': ':0', 07:52:43 INFO - 'HOME': '/home/cltbld', 07:52:43 INFO - 'LANG': 'en_US.UTF-8', 07:52:43 INFO - 'LANGUAGE': 'en_US:en', 07:52:43 INFO - 'LOGNAME': 'cltbld', 07:52:43 INFO - 'MAIL': '/var/mail/cltbld', 07:52:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:52:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:43 INFO - 'MOZ_NO_REMOTE': '1', 07:52:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:43 INFO - 'NO_EM_RESTART': '1', 07:52:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:43 INFO - 'PWD': '/builds/slave/test', 07:52:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:52:43 INFO - 'SHELL': '/bin/bash', 07:52:43 INFO - 'SHLVL': '1', 07:52:43 INFO - 'TERM': 'linux', 07:52:43 INFO - 'TMOUT': '86400', 07:52:43 INFO - 'USER': 'cltbld', 07:52:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662', 07:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:43 INFO - '_': '/tools/buildbot/bin/python'} 07:52:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:52:43 INFO - mozversion application_buildid: 20160822063914 07:52:43 INFO - mozversion application_changeset: 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 07:52:43 INFO - mozversion application_display_name: Nightly 07:52:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:52:43 INFO - mozversion application_name: Firefox 07:52:43 INFO - mozversion application_remotingname: firefox 07:52:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:52:43 INFO - mozversion application_vendor: Mozilla 07:52:43 INFO - mozversion application_version: 51.0a1 07:52:43 INFO - mozversion platform_buildid: 20160822063914 07:52:43 INFO - mozversion platform_changeset: 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 07:52:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:52:43 INFO - mozversion platform_version: 51.0a1 07:52:43 INFO - using testdate: 1471877563 07:52:43 INFO - actual date: 1471877563 07:52:43 INFO - starting webserver on 'localhost:49091' 07:52:43 INFO - SUITE-START | Running 2 tests 07:52:43 INFO - TEST-START | dromaeo_css 07:52:43 INFO - operating with platform_type : linux_ 07:52:43 INFO - Initialising browser for dromaeo_css test... 07:52:43 INFO - TEST-INFO | started process 4057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg12CWd/profile http://localhost:49091/getInfo.html) 07:52:47 INFO - PROCESS | 4057 | __metrics Screen width/height:1600/1200 07:52:47 INFO - PROCESS | 4057 | colorDepth:24 07:52:47 INFO - PROCESS | 4057 | Browser inner width/height: 1024/697 07:52:47 INFO - PROCESS | 4057 | __metrics 07:52:47 INFO - PROCESS | 4057 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:52:47 INFO - PROCESS | 4057 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:52:48 INFO - PROCESS | 4057 | console.error: PushService: 07:52:48 INFO - PROCESS | 4057 | stateChangeProcessEnqueue: Error transitioning state 07:52:48 INFO - PROCESS | 4057 | UnknownError 07:52:49 INFO - TEST-INFO | 4057: exit 0 07:52:49 INFO - Browser initialized. 07:52:49 INFO - Running cycle 1/1 for dromaeo_css test... 07:52:49 INFO - TEST-INFO | started process 4138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg12CWd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:01 INFO - PROCESS | 4138 | RSS: Main: 175173632 07:53:01 INFO - PROCESS | 4138 | 07:53:53 INFO - PROCESS | 4138 | 1471877633097 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:56:05 INFO - PROCESS | 4138 | Cycle 1(1): loaded http://localhost:49091/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49091/tests/dromaeo/cssquery-ext.html) 07:56:06 INFO - PROCESS | 4138 | RSS: Main: 271249408 07:56:06 INFO - PROCESS | 4138 | 07:59:09 INFO - PROCESS | 4138 | Cycle 1(1): loaded http://localhost:49091/tests/dromaeo/cssquery-ext.html (next: http://localhost:49091/tests/dromaeo/cssquery-jquery.html) 07:59:09 INFO - PROCESS | 4138 | RSS: Main: 280834048 07:59:09 INFO - PROCESS | 4138 | 08:02:11 INFO - PROCESS | 4138 | Cycle 1(1): loaded http://localhost:49091/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49091/tests/dromaeo/cssquery-mootools.html) 08:02:12 INFO - PROCESS | 4138 | RSS: Main: 217968640 08:02:12 INFO - PROCESS | 4138 | 08:05:15 INFO - PROCESS | 4138 | Cycle 1(1): loaded http://localhost:49091/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49091/tests/dromaeo/cssquery-prototype.html) 08:05:15 INFO - PROCESS | 4138 | RSS: Main: 219308032 08:05:15 INFO - PROCESS | 4138 | 08:08:18 INFO - PROCESS | 4138 | Cycle 1(1): loaded http://localhost:49091/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49091/tests/dromaeo/cssquery-yui.html) 08:08:19 INFO - PROCESS | 4138 | RSS: Main: 219754496 08:08:19 INFO - PROCESS | 4138 | 08:11:22 INFO - PROCESS | 4138 | Cycle 1(1): loaded http://localhost:49091/tests/dromaeo/cssquery-yui.html (next: http://localhost:49091/tests/dromaeo/cssquery-dojo.html) 08:11:22 INFO - PROCESS | 4138 | RSS: Main: 307822592 08:11:22 INFO - PROCESS | 4138 | 08:11:22 INFO - PROCESS | 4138 | __start_tp_report 08:11:22 INFO - PROCESS | 4138 | _x_x_mozilla_page_load 08:11:22 INFO - PROCESS | 4138 | _x_x_mozilla_page_load_details 08:11:22 INFO - PROCESS | 4138 | |i|pagename|runs| 08:11:22 INFO - PROCESS | 4138 | |0;dojo.html;2512.7864131548813;2553.3744232663003;2561.5645340292135;2568.74312568743;2573.2923446052346;4652.627789776819;4662.51043640418;4741.596964258038;4752.097101550703;4759.214729569621;4724.24412094065;4744.0511897620445;4762.523747625236;4772.284157376395;4781.832635857746;4331.480222373311;4360.996970696741;4374.337353595576;4411.713238639494;4420.77896105195;4397.384366188736;4417.845375411861;4436.8668939931695;4445.666575006871;4451.866444006685;4249.3413520904;4267.210566045292;4317.568243175689;4324.65402767781;4399.340098985146;4360.498542667602;4368.563143685637;4368.934465983013;4368.956310436918;4382.430284063052;4340.696151269412;4340.8480703175555;4353.73877567347;4356.194104090753;4360.520342762294;4508.188526065307;4600.907981840378;4706.670533062687;4720.386349774507;4725.267583524559;5010.72441015744;5027.622928280393;5032.672876263068;5033.874153146164;5039.92440113395;5070.873228169288;5071.644984851062;5076.771545280471;5079.568236699885;5087.3386459759995;4518.073794872043;4643.86068417948;4668.976655116703;4684.976575117103;4698.08387364464;5194.35070616173;5209.895802084013;5210.036143313499;5215.58275337972;5223.268742376071;4988.077205716954;5037.496250375007;5043.5965122790085;5048.040872234264;5051.696898186121;4974;4995.100881841231;5008.424031236382;5021.146405111067;5126.128558145124;4999.250112483084;5036.169032109734;5047.470015648378;5051;5053.267276244997;5019.42276638184;5037.848864533997;5041.117804384218;5043.243513472935;5045.217991211295;4223.049813791872;4273.893152671146;4274.914501710011;4291.291936830388;4378.846740364072;3755.08000539864;3805.5623603285976;3809.8285577149095;3810.1808111256214;3827.6172382762056;4403.163398954189;4406.515283318832;4406.986393129599;4409.470863496401;4413.40419043425;4814.975925120352;4997.750112494434;5176.275321454999;5181.5854731621375;5186.92219616706;4344.847930322424;4356.803943822536;4359.06280149763;4360.65114790816;4365.192439398658;4652.581267685924;4654.045920586272;4655.464621568495;4659.487456379796;4659.510751371057;4560.2475591528355;4608.746518941491;4760.97619511914;4769.499202583679;4773.188557945227;5033.370828646419;5097.362829646294;5113.8721531962;5123.436421993503;5128.256402821496;4690.9765451172525;4708.576228139484;4709.788059537261;4711.623070154448;4722;4777.402824646919;4891.706497610155;5015.448300686994;5022.296878437095;5026.673266237683;5020.974895125501;5102.515261050195;5105.2086926526445;5114.795408183631;5123;4930.482299358516;4985.326980857538;5007.24891266313;5010;5011.072951503984;4823.300621409806;4843.612510999041;4925.802967881388;4948.604111671129;4954.900901981868;4785.569298763128;4845.5881250094135;4869.123557759637;4871.610271178226;4872.488388719134;4946;4947.2579113133315;4965.577925876341;4978.775955082103;4987.650864439454;4711.81152753886;4772.5227477252;4809.0862736081435;4825.276208568603;4833.806647734052 08:11:22 INFO - PROCESS | 4138 | |1;ext.html;553.0653196098596;557.1614719846631;568.176144590344;574.3194314737037;583.1398686936769;38012.61987380125;39397.4090388644;39459.80270098649;43035.35446968298;43210.351844722354;40557.39163912544;40900.38649420261;40962.38556421656;41043.38434923479;41056.38415423763;7627.122880868702;7762.495437796553;7767.9611601941915;7770.8445831083345;7777.377809775205;7663.770086897402;7729.188435214306;7754.922450775504;7755.030621172354;7755.844883102334;7756.146823849372;7764.689412423524;7791.22087791222;7793.4934229275195;7797.337226335769;7715.459917805756;7715.922840771576;7742.303192712627;7753.340966017895;7763.262490063435;7591.582462964535;7662.808429789244;7671.7314893979;7672.65473053714;7678.155402905676;37797.81101094504;38305.616943830486;38306.42540361897;38353.42469862954;38371.424428633596;2626.1990093021623;2667.0531961153706;2698.163569293525;2730.2901245676067;2922.4447355002694;28946.828987825786;29202.269943251587;29214.561781573295;29452.8527357364;30275;3541.4687796830426;3568.37553428149;3602.3335682898746;3620.2216523447323;3646.6717995380545;240358.99999999825;241421;243017;243452;243976.5812880291;52515.737421312646;52966;52980.47019529832;53037;53072.203916941275;32143.35713285721;33099;33192.66807331944;34996.65003349934;48976.265356019685;13151.21092734439;13358.732825343439;13361.331933403291;13380.933095334656;13381.598552043455;9908.603655853685;9989.750256243507;9992.050755178247;9992.10071093605;9999.750006249902;18307.63384732298;18361.265549377877;18363.17365718519;18367.265309387476;18396.81603183978;6579.374959378852;6729.327067293231;6743.15710536183;6819.7272109116075;6828.760993365208;742.3430264216099;789.0728394136867;790.537535541703;834.4742812028384;956.3353469338882;25282;26570.553036627443;27287.181384558495;27782.722172778416;27949.441011179664;931.3527098666361;956.063058202965;956.8516879883629;964.5466630683568;969.9757506062264;14284.214368209849;14309.21299328547;14440.422383104768;14546.199959002144;14604.488842890449;367492;371867;371995;372201;373429;50122.749386252835;50537.74731126394;50892.74553627208;50987.74506127446;51066.23400648993;1070.973225669349;1131.5586921100778;1135.47768026707;1166.6033548593518;1169.0063446071113;28045.439091218468;28974;29098.127056188347;29460.705392945798;29930.401391972475;42295.3655695171;42778;42814;42869.28352896508;42902.78548607237;282708;283529;284347;284480;284626;20672;24453.633195502436;24560.38599034967;25390.746092538837;26239.475210496064;42363.1527369457;42388;42406.151876962904;42501.362479562216;42537.36193957031;36091.63908360988;36109;36239.81880090583;36762.448563271035;36813.07967300732;36279.63720362762;36823.63176368202;37301.81349093237;37341;37377.25245495129;34744.42805310724;34946.30107397889;35784.284314314085;36630.08424789402;38412.80793596014;31448.842755786074;33042.237926855305;33659.66340336565;33668.66331336655;34006.48990265198;25289.367765806;25565.23304300874;25613.74386256188;25670;25913.481730365664 08:11:22 INFO - PROCESS | 4138 | |2;jquery.html;341.8446693596871;345.97578169528146;347.8017530007895;351.6079571278024;379.3058702574289;12811.359432028396;15698.52904412868;16355.936864103825;16958.915205423986;18127;15902.284397202126;16026.83973160271;16110.194490275499;16138.677226455464;16240.51278461645;4988.077205716936;5139.665921715076;5201.2458193561915;5345.732713364336;5378.2470454136455;3441.328940856534;5207.218917162418;5499.065158922973;5545.584081193927;5546.833594992157;5454.318210223722;5525.613207075507;5545.057340252147;5550.417206193352;5560.610757246974;5545.916811247835;5549.722513874311;5682.289713785777;5991.910121348184;6026.668533230671;5304.443033481468;5316.76074576645;5325.520703136736;5325.760340784674;5329.813456529003;12105.273683579013;12258.44836982338;12298.508059677602;12311.630651080392;12343;1710.9828901710948;1734.9913250433792;1740.3995621510685;1754.3859649122833;1772.6897792886193;8671.479711217347;9105.954470227607;9365.531723413802;9546.42721436716;9569.28230382717;1585.5401933439289;1647.3575305630814;1717.2015013019006;1755.6664233795539;1757.8066412694593;65314.67342663304;68476.6576167121;69520.99999999949;69890.30109698889;70536.64731676309;9588.185004274716;9625.56684949179;9746.646209528355;9896.356736812084;9904.653337133166;13384.397702103428;13387.129836560593;13394.263315517544;13411.262380569162;13435.12671676338;6649.368310010541;6783.559068660521;6869.9351600502005;6972;6977.267386924402;6324.083007963912;6331.651759153291;6526.151600291932;6535.8692826143215;6562.146920900253;4025.396190571379;4146.37804329353;4177.6866734995;4273.87178384649;4287.528371879091;1730.2127531972922;1756.657451796913;1760.779902512186;1766.355280322673;1807.9457616271534;755.4032314471506;764.8679953668491;780.5121798875703;823.6787652815407;883.2271762208068;16050.197490125447;16386.508404747878;16636.916815415847;16640.50078497647;17035.91482042582;804.3685706720197;812.0742353716768;827.5820710541259;863.8013256950936;878.9604467798964;8483.88531562192;9472.810543789086;9476.668316608886;9590.376625519459;9671.354068737479;370428;379747;382979;384617;385689;68916.310836892;69649;71364.38945027377;71823.64088179526;72296.27703722895;884.8584226523855;906.8775715278352;913.0823522360118;922.1424075609614;923.3213588012806;14576.052556583789;14823.925880370529;14977.925110374379;15047;15404.46084387041;36665.23351964228;37916.43125353177;38958.80520597379;39324.410133848585;39881.401778973915;49826.501734983634;50612.74693626508;50980.235296469844;52637.21044184264;53350.46649533455;7558.281963213486;7657.272559106876;7725.613719313899;7827.334676552329;7856.489328193649;10535.578576857146;11726.589569365031;11796.233244839059;12264.75470490603;12639.304838233618;9412.23351265176;9512.857307140537;9712.931577526608;9767.511624418892;9815.2147828175;9832.508374581384;9893.307468477138;9969.50152492387;10151.492425378554;10474.68575942723;8829.337799664921;9320.440773553608;9737.415755054719;9918.752031199278;10170.033846784543;6500.6424646643;6659.833504162435;6676.49926255523;6783.762568310283;7006.614636195059;7458.47790654649;8897.553172877251;9272.675456358995;9626.422414655142;9684.612615495584 08:11:22 INFO - PROCESS | 4138 | |3;mootools.html;1241.0753988278734;1362.3188405797102;1383.0111470298734;1445.660269836589;1694.5001224638722;6334.461570766484;7069.222385537593;7253.492255542114;7328.963355183223;7494.1381741099785;7412.073490813648;7472.925270747291;7473.439492038092;7473.514221575594;7478.626068696571;2136.732908386448;2164.037003533428;2164.3290579920276;2168.176093084626;2170.9891450542727;2092.5187206942414;2123.4054464749893;2154.91380344786;2157.46063484129;2162.9725880206934;2111.80993710566;2143.517708515587;2157.913683452668;2159.66525188596;2160.2223199648192;2108.167273926798;2111.4721319670084;2115.502856828644;2115.7249557557575;2115.7672656007826;2027.2499175305084;2102.0120543344606;2102.737157855268;2105.2421128393767;2108.1040557763044;7368.4473664474845;7387.852242955165;7456.142543607501;7465.216152303984;7470.775876723707;4193.35003074524;4310.396544483775;4310.849120280806;4311.331743579719;4328.4156638853665;2691.4213444109414;2877.338212211182;2918.8394638294885;2923.72224638659;2935.060780550225;858.9226969572705;862.2627653356353;872.9388942774009;875.3741075131312;881.6517475597167;9802.803943921153;9872.407655540619;9875.703728888073;9902.702918912444;9906.36544970079;3734.327820992193;3885.592012838668;3922.2155568886337;4018.2767101921936;4043.029672878488;7910.288074073361;7910.288074073361;7917.287444129941;7921.564313962787;7922.128565857751;4240.745555266694;4262.744235345889;4263.211305908417;4264.402983582301;4267.125239325931;3413.2490852012515;3800.467934489174;3887.8056097195026;3888.3972984187494;3935.74417662851;3291.6214635316765;3301.7853839500353;3392.6437724039115;3410.7782994105305;3428.177237462991;1028.29047956911;1046.8639076920103;1049.7008352619466;1069.7806949575318;1073.6617965340893;704.1233664088243;732.1104857598044;744.2966396755014;754.8490301939524;772.2817779465039;4642.79107440166;4721.079389519011;4845.418549773979;4899.191633380524;4942.752862356868;406.4249087541096;809.951402915827;921.8198959460827;949.7862980829258;951.2342564235719;3419.9316013679586;3491.0748651607346;3541.9291614167573;3581.212133330663;3591.6408359164398;8829.381943264038;8955.373123881396;9032.8645070324;9103.726888193365;9133.178013978773;8911.465312081296;9018.413803102778;9024.729258122266;9032.45805251687;9037.909620903707;6926.445884329241;6966.303369662993;6990.895136572955;7033.577985320897;7039.753608623776;4963.950360496493;5018.924716129188;5110.335656364798;5118.616103792305;5184.274201611853;7908.248716371935;8174.427790054639;8189.344852411912;8251.628676709443;8391.32869370461;8362.665493380196;8404.831903362021;8458.323334133378;8468.830623387374;8503.149685031447;5528.502434780889;5944.554158438048;5991.2510936132985;6035.517158627387;6041.9395806041375;6807.829804254933;7041.155061392461;7052.2242553318065;7056.047433596399;7060.858782824417;6213.689315534296;6250.718717657625;6269.31037585856;6304.464120549805;6375.649339286384;5908.05471124618;5952.732127054206;6001.849953751016;6085.087236914498;6121.571489995836;5761.423857614205;5795.39148389413;5836.883262334814;5845.1232315153065;5848.707564621667;4509.842155524541;4518.164139634178;4519.38988236597;4586.793594288331;4691.413573303337;4465.240909045535;4471.105778844179;4493.123840851003;4550.294704320836;4598.9422432839965 08:11:22 INFO - PROCESS | 4138 | |4;prototype.html;286.28857289635266;287.51266603107734;298.6729531163377;301.663645035785;301.8867924528302;4832.960913403617;4858.684185527938;4870.951290487094;4897.191963326047;4925.655204135712;4769.642276829243;4805.831795887145;4829.348038014867;4866.975665121669;4878.609711223094;3613.765105268162;3713.8700145494777;3719.460678201659;3758.9436158457647;3800.5059342285463;3774.169682669808;3793.013816407726;3793.355129627956;3810.428435734634;3836.4437156612275;3749.662530372266;3760.3795373763433;3765.2281282337194;3771.3023090728166;3778.771899132793;3580.767250128746;3652.3790955537625;3762.7366084374103;3790.1472168762084;3793.8103094845424;3332.4334863073336;3335.533025376449;3339.1819004343847;3344.347852168828;3365.6297807241185;4698.107359601665;4705.788239529229;4712.868911461224;4728.612050914301;4750.2874568814605;4098.770368889322;4289.935650965238;4358.825646974149;4367.563243675639;4372.103718737651;4966.50334966504;4975.875603109915;4978.153713868651;4981.132075471698;4993.875153121201;3628.5282913221113;3628.6734193922675;3636.1636823530735;3639.1266096136737;3670.394384926484;5180.248863914711;5263.421023687391;5283.682979021271;5286.36563612369;5338.679679219221;3676.8713095041544;3704.5554533456157;3714.925701485955;3721.6464435878547;3743.232637309345;3765.7363984521367;3785.5078839750654;3786.2995345861104;3792.2605092007348;3801;4318.265894797892;4330.112326972963;4334.13317336534;4339.761313127745;4344.913101737948;4834.178189707688;5002.349694539686;5008.749562521859;5052.418971818214;5067.3412456381175;1308.5943357559188;1320.5906169087614;1327.5950834995226;1327.8074679171466;1328.136711137768;813.7233340664084;825.9587020649063;829.4318391901446;846.3356265331685;863.9977625953863;4237.957620423818;4363.80362883671;4401.559844015637;4409.294512877924;4421;5128.6666366686795;5166.664166829144;5201.1678131498775;5206.869828254324;5224.843254702365;4437.201303765289;4453.576910193527;4470.2177119004045;4498.302763071729;4507.774611269423;2657.309099634109;2713.819488522499;2718.632984547061;2724.741149590786;2780.5273103572035;4764.976175119172;4807.855764327076;4813.895037700663;4820.276958456189;4843.321934929113;5108.9744551277745;5339.86650333737;5347.385050719139;5359.517643412111;5359.517643412111;4802.543758342952;4848.515148485194;4853.247746599282;4856.125897338513;4871.14754917888;5209.661372010807;5225.895482090413;5239.528442440199;5242.082635538842;5262.236975638434;4946.614947814618;5109.131447653834;5109.9744501277255;5112.335396398445;5141.408737995179;4811.446683631427;4834.516548345137;4839.806407743651;4842.83050093245;4843.571146511717;3756.9060773479787;3763.5107436034236;3776.773393596393;3799.259144466913;3802.2395520896484;5019.297298378157;5265.788868560329;5269.841904742864;5285.867853303698;5286.656367336111;5045.369328833895;5055.924161137659;5056.418511871035;5080.7298175456135;5084.559411482435;5008.348914641073;5008.821162794196;5018.799248030038;5045.596352291881;5048.545630893237;4694.507076757028;4927.359443272351;4951.356323677899;4962.727050012139;4969.850904472872;4862.92705609409;4945.78828187082;5090.974545127251;5102.744862756773;5113.181890897438;4912.95087049125;4915.311856340044;4925.556699896883;4942.4810394909455;4955.132851751001 08:11:22 INFO - PROCESS | 4138 | |5;yui.html;555.3225065420188;562.4066609726738;564.3425409398052;573.0515996026578;628.1143587541567;11733.47199376028;12858.807117893239;12863.29251891148;12871.420786064626;12878.484860605564;13657.726845463085;14307.57077287683;14441;14726.779098313507;14726.779098313535;760.7185341423667;781.413939545341;782.5109306683323;782.769083120478;782.9647665855022;634.8888944434729;753.3521171792254;773.609327289718;774.8101715079813;780.2665494435241;814.1044850664281;814.3322475570035;821.1624143373755;821.7699044267584;822.9135940726227;811.0632219786156;811.2212276214841;811.3792948394483;812.4475356757432;817.0726225733805;479.79608666316676;556.1713047559148;587.1193210184723;588.7998080652555;591.2136857978878;13005.544805931748;13024.609261722164;13038.60884173467;13046.41291141901;13056.804147937788;12030.218035827644;12377.69055773604;12601.558945436866;12672.239665620093;13371.665708357272;12145.271283723005;12197.08521860864;12289.631311060682;12373.257604543756;12568.434420451102;3083.5683004379407;3308.536804847299;3311.387393332241;4154;4180.853670121562;57432.23353672842;58737.706311468595;58778.412215877725;58956;59754.402455975316;10228.590856365661;10395.140088821223;10458;10532.526036328383;10639.148868090535;18007.639847202983;18172.545686357946;18173.909130454264;18233.088345582666;18248.543786405447;6477.773277935344;6524.7390104396245;6532.183477065367;6638.601683898982;6731.427828634523;3370.7808992415416;3407.182276253731;3516.2440075383915;3516.40221162403;3640.25374798171;2650.973490265111;2772.37621535157;2775.098093119744;2793.1062060140966;2803.074985254861;479.6139108018079;483.34748090078114;483.4971629505275;489.056121685144;496.386962101804;423.89614544436193;480.6587323000639;509.41926204127327;517.5626595526774;540.9120350455597;7174.605396703231;7250.60121693312;7417.406607471389;7655.311022008046;7934.722284720007;445.9264221403497;469.58207195595946;482.6717831874359;505.05050505051;535.9142537194031;3330.1341651170387;3352.7150192233935;3450.240946991658;3518.3842827505086;3586.7847929124337;53817.1927421089;95179.52410237904;98319;110314;110342;49769;64984.35015649783;67005;67412;81152.59423702843;41657.37513937293;41819.636072785564;42155.36766948437;42267;43189.56810431981;8411.495310281403;8496.53269070207;8755.518446485505;8820.07813002873;8856.855816185162;32258.516122258654;41741.79129104335;43126.78436607797;43409;43802.561974381126;36870.44694329641;37587.248255034196;38233;55780;56928;10530.157587393143;10801.513931872927;11109.222354435435;11317;11556.996668253427;12597.559085431965;12610.810837837256;12959.222446653232;13090.345482725636;13712.314384280546;11473.483693233991;11974.161808673658;12153.635390938285;12707.745845082862;12724.618261452171;10825.458727063773;10874.836877447004;11224.102071834397;11742.295462272292;11803.881961180621;11209.15931305139;11752.823707644222;11832.70418239551;12400.689982750504;12565.43455544521;9376.48429336393;9416.340856140005;9800.411975281506;9814.312998090065;10162.23783216247;8856.778580535538;9299.67451139207;9912.405255684682;9997.100260976547;10070.19438444908 08:11:22 INFO - PROCESS | 4138 | __end_tp_report 08:11:22 INFO - PROCESS | 4138 | __start_cc_report 08:11:22 INFO - PROCESS | 4138 | _x_x_mozilla_cycle_collect,1047 08:11:22 INFO - PROCESS | 4138 | __end_cc_report 08:11:22 INFO - PROCESS | 4138 | __startTimestamp1471878682834__endTimestamp 08:11:22 INFO - PROCESS | 4138 | 08:11:22 INFO - PROCESS | 4138 | ------- Summary: start ------- 08:11:22 INFO - PROCESS | 4138 | Number of tests: 6 08:11:22 INFO - PROCESS | 4138 | 08:11:22 INFO - PROCESS | 4138 | [#0] dojo.html Cycles:165 Average:4673.62 Median:4769.50 stddev:496.90 (10.4%) stddev-sans-first:468.62 08:11:22 INFO - PROCESS | 4138 | Values: 2512.8 2553.4 2561.6 2568.7 2573.3 4652.6 4662.5 4741.6 4752.1 4759.2 4724.2 4744.1 4762.5 4772.3 4781.8 4331.5 4361.0 4374.3 4411.7 4420.8 4397.4 4417.8 4436.9 4445.7 4451.9 4249.3 4267.2 4317.6 4324.7 4399.3 4360.5 4368.6 4368.9 4369.0 4382.4 4340.7 4340.8 4353.7 4356.2 4360.5 4508.2 4600.9 4706.7 4720.4 4725.3 5010.7 5027.6 5032.7 5033.9 5039.9 5070.9 5071.6 5076.8 5079.6 5087.3 4518.1 4643.9 4669.0 4685.0 4698.1 5194.4 5209.9 5210.0 5215.6 5223.3 4988.1 5037.5 5043.6 5048.0 5051.7 4974.0 4995.1 5008.4 5021.1 5126.1 4999.3 5036.2 5047.5 5051.0 5053.3 5019.4 5037.8 5041.1 5043.2 5045.2 4223.0 4273.9 4274.9 4291.3 4378.8 3755.1 3805.6 3809.8 3810.2 3827.6 4403.2 4406.5 4407.0 4409.5 4413.4 4815.0 4997.8 5176.3 5181.6 5186.9 4344.8 4356.8 4359.1 4360.7 4365.2 4652.6 4654.0 4655.5 4659.5 4659.5 4560.2 4608.7 4761.0 4769.5 4773.2 5033.4 5097.4 5113.9 5123.4 5128.3 4691.0 4708.6 4709.8 4711.6 4722.0 4777.4 4891.7 5015.4 5022.3 5026.7 5021.0 5102.5 5105.2 5114.8 5123.0 4930.5 4985.3 5007.2 5010.0 5011.1 4823.3 4843.6 4925.8 4948.6 4954.9 4785.6 4845.6 4869.1 4871.6 4872.5 4946.0 4947.3 4965.6 4978.8 4987.7 4711.8 4772.5 4809.1 4825.3 4833.8 08:11:22 INFO - PROCESS | 4138 | 08:11:22 INFO - PROCESS | 4138 | [#1] ext.html Cycles:180 Average:45338.28 Median:205385.00 stddev:79889.01 (38.9%) stddev-sans-first:80042.35 08:11:22 INFO - PROCESS | 4138 | Values: 553.1 557.2 568.2 574.3 583.1 38012.6 39397.4 39459.8 43035.4 43210.4 40557.4 40900.4 40962.4 41043.4 41056.4 7627.1 7762.5 7768.0 7770.8 7777.4 7663.8 7729.2 7754.9 7755.0 7755.8 7756.1 7764.7 7791.2 7793.5 7797.3 7715.5 7715.9 7742.3 7753.3 7763.3 7591.6 7662.8 7671.7 7672.7 7678.2 37797.8 38305.6 38306.4 38353.4 38371.4 2626.2 2667.1 2698.2 2730.3 2922.4 28946.8 29202.3 29214.6 29452.9 30275.0 3541.5 3568.4 3602.3 3620.2 3646.7 240359.0 241421.0 243017.0 243452.0 243976.6 52515.7 52966.0 52980.5 53037.0 53072.2 32143.4 33099.0 33192.7 34996.7 48976.3 13151.2 13358.7 13361.3 13380.9 13381.6 9908.6 9989.8 9992.1 9992.1 9999.8 18307.6 18361.3 18363.2 18367.3 18396.8 6579.4 6729.3 6743.2 6819.7 6828.8 742.3 789.1 790.5 834.5 956.3 25282.0 26570.6 27287.2 27782.7 27949.4 931.4 956.1 956.9 964.5 970.0 14284.2 14309.2 14440.4 14546.2 14604.5 367492.0 371867.0 371995.0 372201.0 373429.0 50122.7 50537.7 50892.7 50987.7 51066.2 1071.0 1131.6 1135.5 1166.6 1169.0 28045.4 28974.0 29098.1 29460.7 29930.4 42295.4 42778.0 42814.0 42869.3 42902.8 282708.0 283529.0 284347.0 284480.0 284626.0 20672.0 24453.6 24560.4 25390.7 26239.5 42363.2 42388.0 42406.2 42501.4 42537.4 36091.6 36109.0 36239.8 36762.4 36813.1 36279.6 36823.6 37301.8 37341.0 37377.3 34744.4 34946.3 35784.3 36630.1 38412.8 31448.8 33042.2 33659.7 33668.7 34006.5 25289.4 25565.2 25613.7 25670.0 25913.5 08:11:22 INFO - PROCESS | 4138 | 08:11:22 INFO - PROCESS | 4138 | [#2] jquery.html Cycles:180 Average:23468.61 Median:5476.69 stddev:62869.69 (1148.0%) stddev-sans-first:63022.07 08:11:22 INFO - PROCESS | 4138 | Values: 341.8 346.0 347.8 351.6 379.3 12811.4 15698.5 16355.9 16958.9 18127.0 15902.3 16026.8 16110.2 16138.7 16240.5 4988.1 5139.7 5201.2 5345.7 5378.2 3441.3 5207.2 5499.1 5545.6 5546.8 5454.3 5525.6 5545.1 5550.4 5560.6 5545.9 5549.7 5682.3 5991.9 6026.7 5304.4 5316.8 5325.5 5325.8 5329.8 12105.3 12258.4 12298.5 12311.6 12343.0 1711.0 1735.0 1740.4 1754.4 1772.7 8671.5 9106.0 9365.5 9546.4 9569.3 1585.5 1647.4 1717.2 1755.7 1757.8 65314.7 68476.7 69521.0 69890.3 70536.6 9588.2 9625.6 9746.6 9896.4 9904.7 13384.4 13387.1 13394.3 13411.3 13435.1 6649.4 6783.6 6869.9 6972.0 6977.3 6324.1 6331.7 6526.2 6535.9 6562.1 4025.4 4146.4 4177.7 4273.9 4287.5 1730.2 1756.7 1760.8 1766.4 1807.9 755.4 764.9 780.5 823.7 883.2 16050.2 16386.5 16636.9 16640.5 17035.9 804.4 812.1 827.6 863.8 879.0 8483.9 9472.8 9476.7 9590.4 9671.4 370428.0 379747.0 382979.0 384617.0 385689.0 68916.3 69649.0 71364.4 71823.6 72296.3 884.9 906.9 913.1 922.1 923.3 14576.1 14823.9 14977.9 15047.0 15404.5 36665.2 37916.4 38958.8 39324.4 39881.4 49826.5 50612.7 50980.2 52637.2 53350.5 7558.3 7657.3 7725.6 7827.3 7856.5 10535.6 11726.6 11796.2 12264.8 12639.3 9412.2 9512.9 9712.9 9767.5 9815.2 9832.5 9893.3 9969.5 10151.5 10474.7 8829.3 9320.4 9737.4 9918.8 10170.0 6500.6 6659.8 6676.5 6783.8 7006.6 7458.5 8897.6 9272.7 9626.4 9684.6 08:11:22 INFO - PROCESS | 4138 | 08:11:22 INFO - PROCESS | 4138 | [#3] mootools.html Cycles:180 Average:4804.58 Median:5356.39 stddev:2641.27 (49.3%) stddev-sans-first:2635.10 08:11:22 INFO - PROCESS | 4138 | Values: 1241.1 1362.3 1383.0 1445.7 1694.5 6334.5 7069.2 7253.5 7329.0 7494.1 7412.1 7472.9 7473.4 7473.5 7478.6 2136.7 2164.0 2164.3 2168.2 2171.0 2092.5 2123.4 2154.9 2157.5 2163.0 2111.8 2143.5 2157.9 2159.7 2160.2 2108.2 2111.5 2115.5 2115.7 2115.8 2027.2 2102.0 2102.7 2105.2 2108.1 7368.4 7387.9 7456.1 7465.2 7470.8 4193.4 4310.4 4310.8 4311.3 4328.4 2691.4 2877.3 2918.8 2923.7 2935.1 858.9 862.3 872.9 875.4 881.7 9802.8 9872.4 9875.7 9902.7 9906.4 3734.3 3885.6 3922.2 4018.3 4043.0 7910.3 7910.3 7917.3 7921.6 7922.1 4240.7 4262.7 4263.2 4264.4 4267.1 3413.2 3800.5 3887.8 3888.4 3935.7 3291.6 3301.8 3392.6 3410.8 3428.2 1028.3 1046.9 1049.7 1069.8 1073.7 704.1 732.1 744.3 754.8 772.3 4642.8 4721.1 4845.4 4899.2 4942.8 406.4 810.0 921.8 949.8 951.2 3419.9 3491.1 3541.9 3581.2 3591.6 8829.4 8955.4 9032.9 9103.7 9133.2 8911.5 9018.4 9024.7 9032.5 9037.9 6926.4 6966.3 6990.9 7033.6 7039.8 4964.0 5018.9 5110.3 5118.6 5184.3 7908.2 8174.4 8189.3 8251.6 8391.3 8362.7 8404.8 8458.3 8468.8 8503.1 5528.5 5944.6 5991.3 6035.5 6041.9 6807.8 7041.2 7052.2 7056.0 7060.9 6213.7 6250.7 6269.3 6304.5 6375.6 5908.1 5952.7 6001.8 6085.1 6121.6 5761.4 5795.4 5836.9 5845.1 5848.7 4509.8 4518.2 4519.4 4586.8 4691.4 4465.2 4471.1 4493.1 4550.3 4598.9 08:11:22 INFO - PROCESS | 4138 | 08:11:22 INFO - PROCESS | 4138 | [#4] prototype.html Cycles:180 Average:4195.79 Median:4809.65 stddev:1212.48 (25.2%) stddev-sans-first:1179.84 08:11:22 INFO - PROCESS | 4138 | Values: 286.3 287.5 298.7 301.7 301.9 4833.0 4858.7 4871.0 4897.2 4925.7 4769.6 4805.8 4829.3 4867.0 4878.6 3613.8 3713.9 3719.5 3758.9 3800.5 3774.2 3793.0 3793.4 3810.4 3836.4 3749.7 3760.4 3765.2 3771.3 3778.8 3580.8 3652.4 3762.7 3790.1 3793.8 3332.4 3335.5 3339.2 3344.3 3365.6 4698.1 4705.8 4712.9 4728.6 4750.3 4098.8 4289.9 4358.8 4367.6 4372.1 4966.5 4975.9 4978.2 4981.1 4993.9 3628.5 3628.7 3636.2 3639.1 3670.4 5180.2 5263.4 5283.7 5286.4 5338.7 3676.9 3704.6 3714.9 3721.6 3743.2 3765.7 3785.5 3786.3 3792.3 3801.0 4318.3 4330.1 4334.1 4339.8 4344.9 4834.2 5002.3 5008.7 5052.4 5067.3 1308.6 1320.6 1327.6 1327.8 1328.1 813.7 826.0 829.4 846.3 864.0 4238.0 4363.8 4401.6 4409.3 4421.0 5128.7 5166.7 5201.2 5206.9 5224.8 4437.2 4453.6 4470.2 4498.3 4507.8 2657.3 2713.8 2718.6 2724.7 2780.5 4765.0 4807.9 4813.9 4820.3 4843.3 5109.0 5339.9 5347.4 5359.5 5359.5 4802.5 4848.5 4853.2 4856.1 4871.1 5209.7 5225.9 5239.5 5242.1 5262.2 4946.6 5109.1 5110.0 5112.3 5141.4 4811.4 4834.5 4839.8 4842.8 4843.6 3756.9 3763.5 3776.8 3799.3 3802.2 5019.3 5265.8 5269.8 5285.9 5286.7 5045.4 5055.9 5056.4 5080.7 5084.6 5008.3 5008.8 5018.8 5045.6 5048.5 4694.5 4927.4 4951.4 4962.7 4969.9 4862.9 4945.8 5091.0 5102.7 5113.2 4913.0 4915.3 4925.6 4942.5 4955.1 08:11:22 INFO - PROCESS | 4138 | 08:11:22 INFO - PROCESS | 4138 | [#5] yui.html Cycles:180 Average:15577.69 Median:41987.50 stddev:21383.37 (50.9%) stddev-sans-first:21413.61 08:11:22 INFO - PROCESS | 4138 | Values: 555.3 562.4 564.3 573.1 628.1 11733.5 12858.8 12863.3 12871.4 12878.5 13657.7 14307.6 14441.0 14726.8 14726.8 760.7 781.4 782.5 782.8 783.0 634.9 753.4 773.6 774.8 780.3 814.1 814.3 821.2 821.8 822.9 811.1 811.2 811.4 812.4 817.1 479.8 556.2 587.1 588.8 591.2 13005.5 13024.6 13038.6 13046.4 13056.8 12030.2 12377.7 12601.6 12672.2 13371.7 12145.3 12197.1 12289.6 12373.3 12568.4 3083.6 3308.5 3311.4 4154.0 4180.9 57432.2 58737.7 58778.4 58956.0 59754.4 10228.6 10395.1 10458.0 10532.5 10639.1 18007.6 18172.5 18173.9 18233.1 18248.5 6477.8 6524.7 6532.2 6638.6 6731.4 3370.8 3407.2 3516.2 3516.4 3640.3 2651.0 2772.4 2775.1 2793.1 2803.1 479.6 483.3 483.5 489.1 496.4 423.9 480.7 509.4 517.6 540.9 7174.6 7250.6 7417.4 7655.3 7934.7 445.9 469.6 482.7 505.1 535.9 3330.1 3352.7 3450.2 3518.4 3586.8 53817.2 95179.5 98319.0 110314.0 110342.0 49769.0 64984.4 67005.0 67412.0 81152.6 41657.4 41819.6 42155.4 42267.0 43189.6 8411.5 8496.5 8755.5 8820.1 8856.9 32258.5 41741.8 43126.8 43409.0 43802.6 36870.4 37587.2 38233.0 55780.0 56928.0 10530.2 10801.5 11109.2 11317.0 11557.0 12597.6 12610.8 12959.2 13090.3 13712.3 11473.5 11974.2 12153.6 12707.7 12724.6 10825.5 10874.8 11224.1 11742.3 11803.9 11209.2 11752.8 11832.7 12400.7 12565.4 9376.5 9416.3 9800.4 9814.3 10162.2 8856.8 9299.7 9912.4 9997.1 10070.2 08:11:22 INFO - PROCESS | 4138 | -------- Summary: end -------- 08:11:22 INFO - PROCESS | 4138 | 08:11:23 INFO - TEST-INFO | 4138: exit 0 08:11:23 INFO - TEST-OK | dromaeo_css | took 1120549ms 08:11:23 INFO - TEST-START | kraken 08:11:23 INFO - operating with platform_type : linux_ 08:11:23 INFO - Initialising browser for kraken test... 08:11:23 INFO - TEST-INFO | started process 4448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZe_4oI/profile http://localhost:49091/getInfo.html) 08:11:28 INFO - PROCESS | 4448 | __metrics Screen width/height:1600/1200 08:11:28 INFO - PROCESS | 4448 | colorDepth:24 08:11:28 INFO - PROCESS | 4448 | Browser inner width/height: 1024/697 08:11:28 INFO - PROCESS | 4448 | __metrics 08:11:28 INFO - PROCESS | 4448 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:11:28 INFO - PROCESS | 4448 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:11:29 INFO - PROCESS | 4448 | console.error: PushService: 08:11:29 INFO - PROCESS | 4448 | stateChangeProcessEnqueue: Error transitioning state 08:11:29 INFO - PROCESS | 4448 | UnknownError 08:11:29 INFO - TEST-INFO | 4448: exit 0 08:11:29 INFO - Browser initialized. 08:11:29 INFO - Running cycle 1/1 for kraken test... 08:11:29 INFO - TEST-INFO | started process 4531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZe_4oI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:41 INFO - PROCESS | 4531 | RSS: Main: 178003968 08:11:41 INFO - PROCESS | 4531 | 08:11:44 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49091/tests/kraken/driver.html?testName=audio-beat-detection) 08:11:45 INFO - PROCESS | 4531 | RSS: Main: 236199936 08:11:45 INFO - PROCESS | 4531 | 08:11:48 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49091/tests/kraken/driver.html?testName=audio-dft) 08:11:49 INFO - PROCESS | 4531 | RSS: Main: 227012608 08:11:49 INFO - PROCESS | 4531 | 08:11:52 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49091/tests/kraken/driver.html?testName=audio-fft) 08:11:53 INFO - PROCESS | 4531 | RSS: Main: 301207552 08:11:53 INFO - PROCESS | 4531 | 08:11:55 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49091/tests/kraken/driver.html?testName=audio-oscillator) 08:11:55 INFO - PROCESS | 4531 | RSS: Main: 210239488 08:11:55 INFO - PROCESS | 4531 | 08:11:58 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49091/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:11:58 INFO - PROCESS | 4531 | RSS: Main: 214216704 08:11:58 INFO - PROCESS | 4531 | 08:12:01 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49091/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:02 INFO - PROCESS | 4531 | RSS: Main: 251523072 08:12:02 INFO - PROCESS | 4531 | 08:12:06 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49091/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:06 INFO - PROCESS | 4531 | RSS: Main: 245301248 08:12:06 INFO - PROCESS | 4531 | 08:12:09 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49091/tests/kraken/driver.html?testName=json-parse-financial) 08:12:10 INFO - PROCESS | 4531 | RSS: Main: 248414208 08:12:10 INFO - PROCESS | 4531 | 08:12:11 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49091/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:12 INFO - PROCESS | 4531 | RSS: Main: 211906560 08:12:12 INFO - PROCESS | 4531 | 08:12:14 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49091/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:15 INFO - PROCESS | 4531 | RSS: Main: 219930624 08:12:15 INFO - PROCESS | 4531 | 08:12:17 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49091/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:18 INFO - PROCESS | 4531 | RSS: Main: 224038912 08:12:18 INFO - PROCESS | 4531 | 08:12:20 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:12:21 INFO - PROCESS | 4531 | RSS: Main: 219443200 08:12:21 INFO - PROCESS | 4531 | 08:12:24 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:25 INFO - PROCESS | 4531 | RSS: Main: 221757440 08:12:25 INFO - PROCESS | 4531 | 08:12:26 INFO - PROCESS | 4531 | Cycle 1(1): loaded http://localhost:49091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49091/tests/kraken/driver.html?testName=ai-astar) 08:12:27 INFO - PROCESS | 4531 | RSS: Main: 273838080 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | __start_tp_report 08:12:27 INFO - PROCESS | 4531 | _x_x_mozilla_page_load 08:12:27 INFO - PROCESS | 4531 | _x_x_mozilla_page_load_details 08:12:27 INFO - PROCESS | 4531 | |i|pagename|runs| 08:12:27 INFO - PROCESS | 4531 | |0;ai-astar;103;115;112;115;117;114;120;114;115;115 08:12:27 INFO - PROCESS | 4531 | |1;audio-beat-detection;152;121;155;183;128;147;152;124;191;122 08:12:27 INFO - PROCESS | 4531 | |2;audio-dft;163;161;161;163;161;160;162;159;163;159 08:12:27 INFO - PROCESS | 4531 | |3;audio-fft;77;76;118;122;76;76;76;125;110;77 08:12:27 INFO - PROCESS | 4531 | |4;audio-oscillator;88;86;146;86;86;86;144;87;87;139 08:12:27 INFO - PROCESS | 4531 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;118;117;117 08:12:27 INFO - PROCESS | 4531 | |6;imaging-darkroom;147;146;147;147;149;147;146;146;146;145 08:12:27 INFO - PROCESS | 4531 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;96;95 08:12:27 INFO - PROCESS | 4531 | |8;json-parse-financial;63;71;67;67;67;68;68;68;68;66 08:12:27 INFO - PROCESS | 4531 | |9;json-stringify-tinderbox;65;66;65;66;66;65;65;66;66;65 08:12:27 INFO - PROCESS | 4531 | |10;stanford-crypto-aes;82;82;82;81;85;82;81;82;82;82 08:12:27 INFO - PROCESS | 4531 | |11;stanford-crypto-ccm;143;134;137;133;136;134;132;134;159;142 08:12:27 INFO - PROCESS | 4531 | |12;stanford-crypto-pbkdf2;175;175;176;174;180;179;173;176;171;175 08:12:27 INFO - PROCESS | 4531 | |13;stanford-crypto-sha256-iterative;70;72;70;69;68;69;68;69;68;69 08:12:27 INFO - PROCESS | 4531 | __end_tp_report 08:12:27 INFO - PROCESS | 4531 | __start_cc_report 08:12:27 INFO - PROCESS | 4531 | _x_x_mozilla_cycle_collect,2036 08:12:27 INFO - PROCESS | 4531 | __end_cc_report 08:12:27 INFO - PROCESS | 4531 | __startTimestamp1471878747153__endTimestamp 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | ------- Summary: start ------- 08:12:27 INFO - PROCESS | 4531 | Number of tests: 14 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:4.40 (3.8%) stddev-sans-first:2.22 08:12:27 INFO - PROCESS | 4531 | Values: 103.0 115.0 112.0 115.0 117.0 114.0 120.0 114.0 115.0 115.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:152.00 stddev:24.80 (16.3%) stddev-sans-first:26.25 08:12:27 INFO - PROCESS | 4531 | Values: 152.0 121.0 155.0 183.0 128.0 147.0 152.0 124.0 191.0 122.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.55 (1.0%) stddev-sans-first:1.50 08:12:27 INFO - PROCESS | 4531 | Values: 163.0 161.0 161.0 163.0 161.0 160.0 162.0 159.0 163.0 159.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:22.23 (29.2%) stddev-sans-first:22.78 08:12:27 INFO - PROCESS | 4531 | Values: 77.0 76.0 118.0 122.0 76.0 76.0 76.0 125.0 110.0 77.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:86.00 stddev:27.32 (31.8%) stddev-sans-first:28.39 08:12:27 INFO - PROCESS | 4531 | Values: 88.0 86.0 146.0 86.0 86.0 86.0 144.0 87.0 87.0 139.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:12:27 INFO - PROCESS | 4531 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 08:12:27 INFO - PROCESS | 4531 | Values: 147.0 146.0 147.0 147.0 149.0 147.0 146.0 146.0 146.0 145.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:12:27 INFO - PROCESS | 4531 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:68.00 stddev:2.00 (2.9%) stddev-sans-first:1.39 08:12:27 INFO - PROCESS | 4531 | Values: 63.0 71.0 67.0 67.0 67.0 68.0 68.0 68.0 68.0 66.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:12:27 INFO - PROCESS | 4531 | Values: 65.0 66.0 65.0 66.0 66.0 65.0 65.0 66.0 66.0 65.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:1.10 (1.3%) stddev-sans-first:1.17 08:12:27 INFO - PROCESS | 4531 | Values: 82.0 82.0 82.0 81.0 85.0 82.0 81.0 82.0 82.0 82.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:136.50 stddev:8.13 (6.0%) stddev-sans-first:8.45 08:12:27 INFO - PROCESS | 4531 | Values: 143.0 134.0 137.0 133.0 136.0 134.0 132.0 134.0 159.0 142.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:175.50 stddev:2.63 (1.5%) stddev-sans-first:2.79 08:12:27 INFO - PROCESS | 4531 | Values: 175.0 175.0 176.0 174.0 180.0 179.0 173.0 176.0 171.0 175.0 08:12:27 INFO - PROCESS | 4531 | 08:12:27 INFO - PROCESS | 4531 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 08:12:27 INFO - PROCESS | 4531 | Values: 70.0 72.0 70.0 69.0 68.0 69.0 68.0 69.0 68.0 69.0 08:12:27 INFO - PROCESS | 4531 | -------- Summary: end -------- 08:12:27 INFO - PROCESS | 4531 | 08:12:28 INFO - TEST-INFO | 4531: exit 0 08:12:28 INFO - TEST-OK | kraken | took 64727ms 08:12:28 INFO - SUITE-END | took 1185s 08:12:28 INFO - Completed test suite (00:19:45) 08:12:28 INFO - javascript benchmark 08:12:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2512.7864131548813, 2553.3744232663003, 2561.5645340292135, 2568.74312568743, 2573.2923446052346, 4652.627789776819, 4662.51043640418, 4741.596964258038, 4752.097101550703, 4759.214729569621, 4724.24412094065, 4744.0511897620445, 4762.523747625236, 4772.284157376395, 4781.832635857746, 4331.480222373311, 4360.996970696741, 4374.337353595576, 4411.713238639494, 4420.77896105195, 4397.384366188736, 4417.845375411861, 4436.8668939931695, 4445.666575006871, 4451.866444006685, 4249.3413520904, 4267.210566045292, 4317.568243175689, 4324.65402767781, 4399.340098985146, 4360.498542667602, 4368.563143685637, 4368.934465983013, 4368.956310436918, 4382.430284063052, 4340.696151269412, 4340.8480703175555, 4353.73877567347, 4356.194104090753, 4360.520342762294, 4508.188526065307, 4600.907981840378, 4706.670533062687, 4720.386349774507, 4725.267583524559, 5010.72441015744, 5027.622928280393, 5032.672876263068, 5033.874153146164, 5039.92440113395, 5070.873228169288, 5071.644984851062, 5076.771545280471, 5079.568236699885, 5087.3386459759995, 4518.073794872043, 4643.86068417948, 4668.976655116703, 4684.976575117103, 4698.08387364464, 5194.35070616173, 5209.895802084013, 5210.036143313499, 5215.58275337972, 5223.268742376071, 4988.077205716954, 5037.496250375007, 5043.5965122790085, 5048.040872234264, 5051.696898186121, 4974.0, 4995.100881841231, 5008.424031236382, 5021.146405111067, 5126.128558145124, 4999.250112483084, 5036.169032109734, 5047.470015648378, 5051.0, 5053.267276244997, 5019.42276638184, 5037.848864533997, 5041.117804384218, 5043.243513472935, 5045.217991211295, 4223.049813791872, 4273.893152671146, 4274.914501710011, 4291.291936830388, 4378.846740364072, 3755.08000539864, 3805.5623603285976, 3809.8285577149095, 3810.1808111256214, 3827.6172382762056, 4403.163398954189, 4406.515283318832, 4406.986393129599, 4409.470863496401, 4413.40419043425, 4814.975925120352, 4997.750112494434, 5176.275321454999, 5181.5854731621375, 5186.92219616706, 4344.847930322424, 4356.803943822536, 4359.06280149763, 4360.65114790816, 4365.192439398658, 4652.581267685924, 4654.045920586272, 4655.464621568495, 4659.487456379796, 4659.510751371057, 4560.2475591528355, 4608.746518941491, 4760.97619511914, 4769.499202583679, 4773.188557945227, 5033.370828646419, 5097.362829646294, 5113.8721531962, 5123.436421993503, 5128.256402821496, 4690.9765451172525, 4708.576228139484, 4709.788059537261, 4711.623070154448, 4722.0, 4777.402824646919, 4891.706497610155, 5015.448300686994, 5022.296878437095, 5026.673266237683, 5020.974895125501, 5102.515261050195, 5105.2086926526445, 5114.795408183631, 5123.0, 4930.482299358516, 4985.326980857538, 5007.24891266313, 5010.0, 5011.072951503984, 4823.300621409806, 4843.612510999041, 4925.802967881388, 4948.604111671129, 4954.900901981868, 4785.569298763128, 4845.5881250094135, 4869.123557759637, 4871.610271178226, 4872.488388719134, 4946.0, 4947.2579113133315, 4965.577925876341, 4978.775955082103, 4987.650864439454, 4711.81152753886, 4772.5227477252, 4809.0862736081435, 4825.276208568603, 4833.806647734052], "value": 4640.802711003998, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.0653196098596, 557.1614719846631, 568.176144590344, 574.3194314737037, 583.1398686936769, 38012.61987380125, 39397.4090388644, 39459.80270098649, 43035.35446968298, 43210.351844722354, 40557.39163912544, 40900.38649420261, 40962.38556421656, 41043.38434923479, 41056.38415423763, 7627.122880868702, 7762.495437796553, 7767.9611601941915, 7770.8445831083345, 7777.377809775205, 7663.770086897402, 7729.188435214306, 7754.922450775504, 7755.030621172354, 7755.844883102334, 7756.146823849372, 7764.689412423524, 7791.22087791222, 7793.4934229275195, 7797.337226335769, 7715.459917805756, 7715.922840771576, 7742.303192712627, 7753.340966017895, 7763.262490063435, 7591.582462964535, 7662.808429789244, 7671.7314893979, 7672.65473053714, 7678.155402905676, 37797.81101094504, 38305.616943830486, 38306.42540361897, 38353.42469862954, 38371.424428633596, 2626.1990093021623, 2667.0531961153706, 2698.163569293525, 2730.2901245676067, 2922.4447355002694, 28946.828987825786, 29202.269943251587, 29214.561781573295, 29452.8527357364, 30275.0, 3541.4687796830426, 3568.37553428149, 3602.3335682898746, 3620.2216523447323, 3646.6717995380545, 240358.99999999825, 241421.0, 243017.0, 243452.0, 243976.5812880291, 52515.737421312646, 52966.0, 52980.47019529832, 53037.0, 53072.203916941275, 32143.35713285721, 33099.0, 33192.66807331944, 34996.65003349934, 48976.265356019685, 13151.21092734439, 13358.732825343439, 13361.331933403291, 13380.933095334656, 13381.598552043455, 9908.603655853685, 9989.750256243507, 9992.050755178247, 9992.10071093605, 9999.750006249902, 18307.63384732298, 18361.265549377877, 18363.17365718519, 18367.265309387476, 18396.81603183978, 6579.374959378852, 6729.327067293231, 6743.15710536183, 6819.7272109116075, 6828.760993365208, 742.3430264216099, 789.0728394136867, 790.537535541703, 834.4742812028384, 956.3353469338882, 25282.0, 26570.553036627443, 27287.181384558495, 27782.722172778416, 27949.441011179664, 931.3527098666361, 956.063058202965, 956.8516879883629, 964.5466630683568, 969.9757506062264, 14284.214368209849, 14309.21299328547, 14440.422383104768, 14546.199959002144, 14604.488842890449, 367492.0, 371867.0, 371995.0, 372201.0, 373429.0, 50122.749386252835, 50537.74731126394, 50892.74553627208, 50987.74506127446, 51066.23400648993, 1070.973225669349, 1131.5586921100778, 1135.47768026707, 1166.6033548593518, 1169.0063446071113, 28045.439091218468, 28974.0, 29098.127056188347, 29460.705392945798, 29930.401391972475, 42295.3655695171, 42778.0, 42814.0, 42869.28352896508, 42902.78548607237, 282708.0, 283529.0, 284347.0, 284480.0, 284626.0, 20672.0, 24453.633195502436, 24560.38599034967, 25390.746092538837, 26239.475210496064, 42363.1527369457, 42388.0, 42406.151876962904, 42501.362479562216, 42537.36193957031, 36091.63908360988, 36109.0, 36239.81880090583, 36762.448563271035, 36813.07967300732, 36279.63720362762, 36823.63176368202, 37301.81349093237, 37341.0, 37377.25245495129, 34744.42805310724, 34946.30107397889, 35784.284314314085, 36630.08424789402, 38412.80793596014, 31448.842755786074, 33042.237926855305, 33659.66340336565, 33668.66331336655, 34006.48990265198, 25289.367765806, 25565.23304300874, 25613.74386256188, 25670.0, 25913.481730365664], "value": 17046.774005475694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.8446693596871, 345.97578169528146, 347.8017530007895, 351.6079571278024, 379.3058702574289, 12811.359432028396, 15698.52904412868, 16355.936864103825, 16958.915205423986, 18127.0, 15902.284397202126, 16026.83973160271, 16110.194490275499, 16138.677226455464, 16240.51278461645, 4988.077205716936, 5139.665921715076, 5201.2458193561915, 5345.732713364336, 5378.2470454136455, 3441.328940856534, 5207.218917162418, 5499.065158922973, 5545.584081193927, 5546.833594992157, 5454.318210223722, 5525.613207075507, 5545.057340252147, 5550.417206193352, 5560.610757246974, 5545.916811247835, 5549.722513874311, 5682.289713785777, 5991.910121348184, 6026.668533230671, 5304.443033481468, 5316.76074576645, 5325.520703136736, 5325.760340784674, 5329.813456529003, 12105.273683579013, 12258.44836982338, 12298.508059677602, 12311.630651080392, 12343.0, 1710.9828901710948, 1734.9913250433792, 1740.3995621510685, 1754.3859649122833, 1772.6897792886193, 8671.479711217347, 9105.954470227607, 9365.531723413802, 9546.42721436716, 9569.28230382717, 1585.5401933439289, 1647.3575305630814, 1717.2015013019006, 1755.6664233795539, 1757.8066412694593, 65314.67342663304, 68476.6576167121, 69520.99999999949, 69890.30109698889, 70536.64731676309, 9588.185004274716, 9625.56684949179, 9746.646209528355, 9896.356736812084, 9904.653337133166, 13384.397702103428, 13387.129836560593, 13394.263315517544, 13411.262380569162, 13435.12671676338, 6649.368310010541, 6783.559068660521, 6869.9351600502005, 6972.0, 6977.267386924402, 6324.083007963912, 6331.651759153291, 6526.151600291932, 6535.8692826143215, 6562.146920900253, 4025.396190571379, 4146.37804329353, 4177.6866734995, 4273.87178384649, 4287.528371879091, 1730.2127531972922, 1756.657451796913, 1760.779902512186, 1766.355280322673, 1807.9457616271534, 755.4032314471506, 764.8679953668491, 780.5121798875703, 823.6787652815407, 883.2271762208068, 16050.197490125447, 16386.508404747878, 16636.916815415847, 16640.50078497647, 17035.91482042582, 804.3685706720197, 812.0742353716768, 827.5820710541259, 863.8013256950936, 878.9604467798964, 8483.88531562192, 9472.810543789086, 9476.668316608886, 9590.376625519459, 9671.354068737479, 370428.0, 379747.0, 382979.0, 384617.0, 385689.0, 68916.310836892, 69649.0, 71364.38945027377, 71823.64088179526, 72296.27703722895, 884.8584226523855, 906.8775715278352, 913.0823522360118, 922.1424075609614, 923.3213588012806, 14576.052556583789, 14823.925880370529, 14977.925110374379, 15047.0, 15404.46084387041, 36665.23351964228, 37916.43125353177, 38958.80520597379, 39324.410133848585, 39881.401778973915, 49826.501734983634, 50612.74693626508, 50980.235296469844, 52637.21044184264, 53350.46649533455, 7558.281963213486, 7657.272559106876, 7725.613719313899, 7827.334676552329, 7856.489328193649, 10535.578576857146, 11726.589569365031, 11796.233244839059, 12264.75470490603, 12639.304838233618, 9412.23351265176, 9512.857307140537, 9712.931577526608, 9767.511624418892, 9815.2147828175, 9832.508374581384, 9893.307468477138, 9969.50152492387, 10151.492425378554, 10474.68575942723, 8829.337799664921, 9320.440773553608, 9737.415755054719, 9918.752031199278, 10170.033846784543, 6500.6424646643, 6659.833504162435, 6676.49926255523, 6783.762568310283, 7006.614636195059, 7458.47790654649, 8897.553172877251, 9272.675456358995, 9626.422414655142, 9684.612615495584], "value": 7837.487325355944, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.0753988278734, 1362.3188405797102, 1383.0111470298734, 1445.660269836589, 1694.5001224638722, 6334.461570766484, 7069.222385537593, 7253.492255542114, 7328.963355183223, 7494.1381741099785, 7412.073490813648, 7472.925270747291, 7473.439492038092, 7473.514221575594, 7478.626068696571, 2136.732908386448, 2164.037003533428, 2164.3290579920276, 2168.176093084626, 2170.9891450542727, 2092.5187206942414, 2123.4054464749893, 2154.91380344786, 2157.46063484129, 2162.9725880206934, 2111.80993710566, 2143.517708515587, 2157.913683452668, 2159.66525188596, 2160.2223199648192, 2108.167273926798, 2111.4721319670084, 2115.502856828644, 2115.7249557557575, 2115.7672656007826, 2027.2499175305084, 2102.0120543344606, 2102.737157855268, 2105.2421128393767, 2108.1040557763044, 7368.4473664474845, 7387.852242955165, 7456.142543607501, 7465.216152303984, 7470.775876723707, 4193.35003074524, 4310.396544483775, 4310.849120280806, 4311.331743579719, 4328.4156638853665, 2691.4213444109414, 2877.338212211182, 2918.8394638294885, 2923.72224638659, 2935.060780550225, 858.9226969572705, 862.2627653356353, 872.9388942774009, 875.3741075131312, 881.6517475597167, 9802.803943921153, 9872.407655540619, 9875.703728888073, 9902.702918912444, 9906.36544970079, 3734.327820992193, 3885.592012838668, 3922.2155568886337, 4018.2767101921936, 4043.029672878488, 7910.288074073361, 7910.288074073361, 7917.287444129941, 7921.564313962787, 7922.128565857751, 4240.745555266694, 4262.744235345889, 4263.211305908417, 4264.402983582301, 4267.125239325931, 3413.2490852012515, 3800.467934489174, 3887.8056097195026, 3888.3972984187494, 3935.74417662851, 3291.6214635316765, 3301.7853839500353, 3392.6437724039115, 3410.7782994105305, 3428.177237462991, 1028.29047956911, 1046.8639076920103, 1049.7008352619466, 1069.7806949575318, 1073.6617965340893, 704.1233664088243, 732.1104857598044, 744.2966396755014, 754.8490301939524, 772.2817779465039, 4642.79107440166, 4721.079389519011, 4845.418549773979, 4899.191633380524, 4942.752862356868, 406.4249087541096, 809.951402915827, 921.8198959460827, 949.7862980829258, 951.2342564235719, 3419.9316013679586, 3491.0748651607346, 3541.9291614167573, 3581.212133330663, 3591.6408359164398, 8829.381943264038, 8955.373123881396, 9032.8645070324, 9103.726888193365, 9133.178013978773, 8911.465312081296, 9018.413803102778, 9024.729258122266, 9032.45805251687, 9037.909620903707, 6926.445884329241, 6966.303369662993, 6990.895136572955, 7033.577985320897, 7039.753608623776, 4963.950360496493, 5018.924716129188, 5110.335656364798, 5118.616103792305, 5184.274201611853, 7908.248716371935, 8174.427790054639, 8189.344852411912, 8251.628676709443, 8391.32869370461, 8362.665493380196, 8404.831903362021, 8458.323334133378, 8468.830623387374, 8503.149685031447, 5528.502434780889, 5944.554158438048, 5991.2510936132985, 6035.517158627387, 6041.9395806041375, 6807.829804254933, 7041.155061392461, 7052.2242553318065, 7056.047433596399, 7060.858782824417, 6213.689315534296, 6250.718717657625, 6269.31037585856, 6304.464120549805, 6375.649339286384, 5908.05471124618, 5952.732127054206, 6001.849953751016, 6085.087236914498, 6121.571489995836, 5761.423857614205, 5795.39148389413, 5836.883262334814, 5845.1232315153065, 5848.707564621667, 4509.842155524541, 4518.164139634178, 4519.38988236597, 4586.793594288331, 4691.413573303337, 4465.240909045535, 4471.105778844179, 4493.123840851003, 4550.294704320836, 4598.9422432839965], "value": 3891.3454586500493, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.28857289635266, 287.51266603107734, 298.6729531163377, 301.663645035785, 301.8867924528302, 4832.960913403617, 4858.684185527938, 4870.951290487094, 4897.191963326047, 4925.655204135712, 4769.642276829243, 4805.831795887145, 4829.348038014867, 4866.975665121669, 4878.609711223094, 3613.765105268162, 3713.8700145494777, 3719.460678201659, 3758.9436158457647, 3800.5059342285463, 3774.169682669808, 3793.013816407726, 3793.355129627956, 3810.428435734634, 3836.4437156612275, 3749.662530372266, 3760.3795373763433, 3765.2281282337194, 3771.3023090728166, 3778.771899132793, 3580.767250128746, 3652.3790955537625, 3762.7366084374103, 3790.1472168762084, 3793.8103094845424, 3332.4334863073336, 3335.533025376449, 3339.1819004343847, 3344.347852168828, 3365.6297807241185, 4698.107359601665, 4705.788239529229, 4712.868911461224, 4728.612050914301, 4750.2874568814605, 4098.770368889322, 4289.935650965238, 4358.825646974149, 4367.563243675639, 4372.103718737651, 4966.50334966504, 4975.875603109915, 4978.153713868651, 4981.132075471698, 4993.875153121201, 3628.5282913221113, 3628.6734193922675, 3636.1636823530735, 3639.1266096136737, 3670.394384926484, 5180.248863914711, 5263.421023687391, 5283.682979021271, 5286.36563612369, 5338.679679219221, 3676.8713095041544, 3704.5554533456157, 3714.925701485955, 3721.6464435878547, 3743.232637309345, 3765.7363984521367, 3785.5078839750654, 3786.2995345861104, 3792.2605092007348, 3801.0, 4318.265894797892, 4330.112326972963, 4334.13317336534, 4339.761313127745, 4344.913101737948, 4834.178189707688, 5002.349694539686, 5008.749562521859, 5052.418971818214, 5067.3412456381175, 1308.5943357559188, 1320.5906169087614, 1327.5950834995226, 1327.8074679171466, 1328.136711137768, 813.7233340664084, 825.9587020649063, 829.4318391901446, 846.3356265331685, 863.9977625953863, 4237.957620423818, 4363.80362883671, 4401.559844015637, 4409.294512877924, 4421.0, 5128.6666366686795, 5166.664166829144, 5201.1678131498775, 5206.869828254324, 5224.843254702365, 4437.201303765289, 4453.576910193527, 4470.2177119004045, 4498.302763071729, 4507.774611269423, 2657.309099634109, 2713.819488522499, 2718.632984547061, 2724.741149590786, 2780.5273103572035, 4764.976175119172, 4807.855764327076, 4813.895037700663, 4820.276958456189, 4843.321934929113, 5108.9744551277745, 5339.86650333737, 5347.385050719139, 5359.517643412111, 5359.517643412111, 4802.543758342952, 4848.515148485194, 4853.247746599282, 4856.125897338513, 4871.14754917888, 5209.661372010807, 5225.895482090413, 5239.528442440199, 5242.082635538842, 5262.236975638434, 4946.614947814618, 5109.131447653834, 5109.9744501277255, 5112.335396398445, 5141.408737995179, 4811.446683631427, 4834.516548345137, 4839.806407743651, 4842.83050093245, 4843.571146511717, 3756.9060773479787, 3763.5107436034236, 3776.773393596393, 3799.259144466913, 3802.2395520896484, 5019.297298378157, 5265.788868560329, 5269.841904742864, 5285.867853303698, 5286.656367336111, 5045.369328833895, 5055.924161137659, 5056.418511871035, 5080.7298175456135, 5084.559411482435, 5008.348914641073, 5008.821162794196, 5018.799248030038, 5045.596352291881, 5048.545630893237, 4694.507076757028, 4927.359443272351, 4951.356323677899, 4962.727050012139, 4969.850904472872, 4862.92705609409, 4945.78828187082, 5090.974545127251, 5102.744862756773, 5113.181890897438, 4912.95087049125, 4915.311856340044, 4925.556699896883, 4942.4810394909455, 4955.132851751001], "value": 3808.0672202313667, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.3225065420188, 562.4066609726738, 564.3425409398052, 573.0515996026578, 628.1143587541567, 11733.47199376028, 12858.807117893239, 12863.29251891148, 12871.420786064626, 12878.484860605564, 13657.726845463085, 14307.57077287683, 14441.0, 14726.779098313507, 14726.779098313535, 760.7185341423667, 781.413939545341, 782.5109306683323, 782.769083120478, 782.9647665855022, 634.8888944434729, 753.3521171792254, 773.609327289718, 774.8101715079813, 780.2665494435241, 814.1044850664281, 814.3322475570035, 821.1624143373755, 821.7699044267584, 822.9135940726227, 811.0632219786156, 811.2212276214841, 811.3792948394483, 812.4475356757432, 817.0726225733805, 479.79608666316676, 556.1713047559148, 587.1193210184723, 588.7998080652555, 591.2136857978878, 13005.544805931748, 13024.609261722164, 13038.60884173467, 13046.41291141901, 13056.804147937788, 12030.218035827644, 12377.69055773604, 12601.558945436866, 12672.239665620093, 13371.665708357272, 12145.271283723005, 12197.08521860864, 12289.631311060682, 12373.257604543756, 12568.434420451102, 3083.5683004379407, 3308.536804847299, 3311.387393332241, 4154.0, 4180.853670121562, 57432.23353672842, 58737.706311468595, 58778.412215877725, 58956.0, 59754.402455975316, 10228.590856365661, 10395.140088821223, 10458.0, 10532.526036328383, 10639.148868090535, 18007.639847202983, 18172.545686357946, 18173.909130454264, 18233.088345582666, 18248.543786405447, 6477.773277935344, 6524.7390104396245, 6532.183477065367, 6638.601683898982, 6731.427828634523, 3370.7808992415416, 3407.182276253731, 3516.2440075383915, 3516.40221162403, 3640.25374798171, 2650.973490265111, 2772.37621535157, 2775.098093119744, 2793.1062060140966, 2803.074985254861, 479.6139108018079, 483.34748090078114, 483.4971629505275, 489.056121685144, 496.386962101804, 423.89614544436193, 480.6587323000639, 509.41926204127327, 517.5626595526774, 540.9120350455597, 7174.605396703231, 7250.60121693312, 7417.406607471389, 7655.311022008046, 7934.722284720007, 445.9264221403497, 469.58207195595946, 482.6717831874359, 505.05050505051, 535.9142537194031, 3330.1341651170387, 3352.7150192233935, 3450.240946991658, 3518.3842827505086, 3586.7847929124337, 53817.1927421089, 95179.52410237904, 98319.0, 110314.0, 110342.0, 49769.0, 64984.35015649783, 67005.0, 67412.0, 81152.59423702843, 41657.37513937293, 41819.636072785564, 42155.36766948437, 42267.0, 43189.56810431981, 8411.495310281403, 8496.53269070207, 8755.518446485505, 8820.07813002873, 8856.855816185162, 32258.516122258654, 41741.79129104335, 43126.78436607797, 43409.0, 43802.561974381126, 36870.44694329641, 37587.248255034196, 38233.0, 55780.0, 56928.0, 10530.157587393143, 10801.513931872927, 11109.222354435435, 11317.0, 11556.996668253427, 12597.559085431965, 12610.810837837256, 12959.222446653232, 13090.345482725636, 13712.314384280546, 11473.483693233991, 11974.161808673658, 12153.635390938285, 12707.745845082862, 12724.618261452171, 10825.458727063773, 10874.836877447004, 11224.102071834397, 11742.295462272292, 11803.881961180621, 11209.15931305139, 11752.823707644222, 11832.70418239551, 12400.689982750504, 12565.43455544521, 9376.48429336393, 9416.340856140005, 9800.411975281506, 9814.312998090065, 10162.23783216247, 8856.778580535538, 9299.67451139207, 9912.405255684682, 9997.100260976547, 10070.19438444908], "value": 6197.035183831323, "unit": "score"}], "name": "dromaeo_css", "value": 6202.618918355879, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 112.0, 115.0, 117.0, 114.0, 120.0, 114.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 155.0, 183.0, 128.0, 147.0, 152.0, 124.0, 191.0, 122.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 163.0, 161.0, 160.0, 162.0, 159.0, 163.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 118.0, 122.0, 76.0, 76.0, 76.0, 125.0, 110.0, 77.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 146.0, 86.0, 86.0, 86.0, 144.0, 87.0, 87.0, 139.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 149.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 66.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 81.0, 85.0, 82.0, 81.0, 82.0, 82.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 137.0, 133.0, 136.0, 134.0, 132.0, 134.0, 159.0, 142.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 176.0, 174.0, 180.0, 179.0, 173.0, 176.0, 171.0, 175.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 70.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1576.4000000000003, "alertThreshold": 2.0}]} 08:12:28 INFO - Return code: 0 08:12:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:12:28 INFO - # TBPL SUCCESS # 08:12:28 INFO - Running post-action listener: _resource_record_post_action 08:12:28 INFO - [mozharness: 2016-08-22 15:12:28.951259Z] Finished run-tests step (success) 08:12:28 INFO - Running post-run listener: _resource_record_post_run 08:12:29 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407441408; Read time: 72; Write time: 287180 08:12:29 INFO - TinderboxPrint: CPU usage
13.2% 08:12:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 72 08:12:29 INFO - TinderboxPrint: I/O write bytes / time
407,441,408 / 287,180 08:12:29 INFO - TinderboxPrint: CPU idle
8,319.9 (86.7%) 08:12:29 INFO - TinderboxPrint: CPU user
1,206.2 (12.6%) 08:12:29 INFO - TinderboxPrint: Swap in / out
0 / 0 08:12:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113545216; Read time: 0; Write time: 74936 08:12:29 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293896192; Read time: 72; Write time: 212244 08:12:29 INFO - Running post-run listener: _upload_blobber_files 08:12:29 INFO - Blob upload gear active. 08:12:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:12:29 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 08:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:12:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:12:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:12:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:12:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:33 INFO - (blobuploader) - INFO - Done attempting. 08:12:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:12:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:12:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:34 INFO - (blobuploader) - INFO - Done attempting. 08:12:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:12:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:35 INFO - (blobuploader) - INFO - Done attempting. 08:12:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:12:35 INFO - Return code: 0 08:12:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:12:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:12:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13d39094ae866bd2b4373356191538790a131e3c181c0c15553f45553855b05381a2dec57a57e56685700163dee457809edfcfa3d8673e14e33c16302963b731", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbf36d0236133acd0181f0f0c2f5994a2b5a0f49bf81196b62649a873baa0385694dc90b9d1dfc8a8d6cd3b24d15adb107a11c1b7ef00fbd6534ac90198ec8f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0203e42e0349bc405312892be1ea63e4cec807b6b7139dbd2f9b8ba58da0edbf85a2d4ecb0887f7d334eb9f1a027712cf4d12f18db65f701e95b5ebe5870a193"} 08:12:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:12:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:12:35 INFO - Contents: 08:12:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13d39094ae866bd2b4373356191538790a131e3c181c0c15553f45553855b05381a2dec57a57e56685700163dee457809edfcfa3d8673e14e33c16302963b731", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbf36d0236133acd0181f0f0c2f5994a2b5a0f49bf81196b62649a873baa0385694dc90b9d1dfc8a8d6cd3b24d15adb107a11c1b7ef00fbd6534ac90198ec8f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0203e42e0349bc405312892be1ea63e4cec807b6b7139dbd2f9b8ba58da0edbf85a2d4ecb0887f7d334eb9f1a027712cf4d12f18db65f701e95b5ebe5870a193"} 08:12:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:12:35 INFO - Copying logs to upload dir... 08:12:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:12:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.491059 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-22 08:12:34.631214) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 08:12:34.635038) ========= 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=1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13d39094ae866bd2b4373356191538790a131e3c181c0c15553f45553855b05381a2dec57a57e56685700163dee457809edfcfa3d8673e14e33c16302963b731", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbf36d0236133acd0181f0f0c2f5994a2b5a0f49bf81196b62649a873baa0385694dc90b9d1dfc8a8d6cd3b24d15adb107a11c1b7ef00fbd6534ac90198ec8f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0203e42e0349bc405312892be1ea63e4cec807b6b7139dbd2f9b8ba58da0edbf85a2d4ecb0887f7d334eb9f1a027712cf4d12f18db65f701e95b5ebe5870a193"} build_url:https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/EihhTdtHR0OYZcPVvYdQRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13d39094ae866bd2b4373356191538790a131e3c181c0c15553f45553855b05381a2dec57a57e56685700163dee457809edfcfa3d8673e14e33c16302963b731", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbf36d0236133acd0181f0f0c2f5994a2b5a0f49bf81196b62649a873baa0385694dc90b9d1dfc8a8d6cd3b24d15adb107a11c1b7ef00fbd6534ac90198ec8f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0203e42e0349bc405312892be1ea63e4cec807b6b7139dbd2f9b8ba58da0edbf85a2d4ecb0887f7d334eb9f1a027712cf4d12f18db65f701e95b5ebe5870a193"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 08:12:34.669782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:12:34.670082) ========= 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=1f5564757af27664ca02d71f000001b0-1471876747.738829-1567597662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:12:34.752527) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 08:12:34.752876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 08:12:34.753173) ========= ========= Total master_lag: 0.19 =========