builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1471821804.44 results: success (0) buildid: 20160821133003 builduid: d9771ec68d66488382d1263cef831fc2 revision: f823117225343b73be4df1ee89c904580d66d148 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:24.440733) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:24.441209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:24.441503) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:24.497906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:24.498217) ========= 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=db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-21 16:23:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-08-21 16:23:27 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109199 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:24.621586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:24.621907) ========= 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=db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017101 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:24.673762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-21 16:23:24.674182) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f823117225343b73be4df1ee89c904580d66d148 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f823117225343b73be4df1ee89c904580d66d148 --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=db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-21 16:23:27,514 truncating revision to first 12 chars 2016-08-21 16:23:27,514 Setting DEBUG logging. 2016-08-21 16:23:27,514 attempt 1/10 2016-08-21 16:23:27,514 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f82311722534?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-21 16:23:28,283 unpacking tar archive at: mozilla-inbound-f82311722534/testing/mozharness/ program finished with exit code 0 elapsedTime=1.069049 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-21 16:23:25.757009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:25.757344) ========= script_repo_revision: f823117225343b73be4df1ee89c904580d66d148 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:25.757763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:25.758038) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 16:23:25.766220) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-21 16:23:25.766499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:23:28 INFO - MultiFileLogger online at 20160821 16:23:28 in /builds/slave/test 16:23:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:23:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:23:28 INFO - {'append_to_log': False, 16:23:28 INFO - 'base_work_dir': '/builds/slave/test', 16:23:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:23:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:23:28 INFO - 'branch': 'Mozilla-Inbound', 16:23:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:23:28 INFO - 'config_files': ('talos/linux_config.py',), 16:23:28 INFO - 'default_actions': ('clobber', 16:23:28 INFO - 'read-buildbot-config', 16:23:28 INFO - 'download-and-extract', 16:23:28 INFO - 'populate-webroot', 16:23:28 INFO - 'create-virtualenv', 16:23:28 INFO - 'install', 16:23:28 INFO - 'run-tests'), 16:23:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:23:28 INFO - 'download_minidump_stackwalk': True, 16:23:28 INFO - 'download_symbols': 'ondemand', 16:23:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:23:28 INFO - 'tooltool.py': '/tools/tooltool.py', 16:23:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:23:28 INFO - '/tools/misc-python/virtualenv.py')}, 16:23:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:23:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:23:28 INFO - 'installer_path': 'installer.exe', 16:23:28 INFO - 'log_level': 'info', 16:23:28 INFO - 'log_name': 'talos', 16:23:28 INFO - 'log_to_console': True, 16:23:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:23:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:23:28 INFO - 'opt_config_files': (), 16:23:28 INFO - 'pip_index': False, 16:23:28 INFO - 'sps_profile': False, 16:23:28 INFO - 'sps_profile_interval': 0, 16:23:28 INFO - 'suite': 'dromaeojs', 16:23:28 INFO - 'system_bits': '32', 16:23:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:23:28 INFO - 'title': 'talos-linux64-ix-049', 16:23:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:23:28 INFO - 'use_talos_json': True, 16:23:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:23:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:23:28 INFO - 'work_dir': 'build'} 16:23:28 INFO - [mozharness: 2016-08-21 23:23:28.703335Z] Running clobber step. 16:23:28 INFO - Running pre-action listener: _resource_record_pre_action 16:23:28 INFO - Running main action method: clobber 16:23:28 INFO - rmtree: /builds/slave/test/build 16:23:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:23:29 INFO - Running post-action listener: _resource_record_post_action 16:23:29 INFO - [mozharness: 2016-08-21 23:23:29.677571Z] Finished clobber step (success) 16:23:29 INFO - [mozharness: 2016-08-21 23:23:29.677670Z] Running read-buildbot-config step. 16:23:29 INFO - Running pre-action listener: _resource_record_pre_action 16:23:29 INFO - Running main action method: read_buildbot_config 16:23:29 INFO - Using buildbot properties: 16:23:29 INFO - { 16:23:29 INFO - "project": "", 16:23:29 INFO - "product": "firefox", 16:23:29 INFO - "script_repo_revision": "production", 16:23:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:23:29 INFO - "repository": "", 16:23:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:23:29 INFO - "buildid": "20160821133003", 16:23:29 INFO - "pgo_build": "True", 16:23:29 INFO - "basedir": "/builds/slave/test", 16:23:29 INFO - "buildnumber": 1440, 16:23:29 INFO - "slavename": "talos-linux64-ix-049", 16:23:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:23:29 INFO - "platform": "ubuntu64_hw", 16:23:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:23:29 INFO - "branch": "mozilla-inbound", 16:23:29 INFO - "repo_path": "integration/mozilla-inbound", 16:23:29 INFO - "revision": "f823117225343b73be4df1ee89c904580d66d148", 16:23:29 INFO - "stage_platform": "linux64-pgo", 16:23:29 INFO - "builduid": "d9771ec68d66488382d1263cef831fc2", 16:23:29 INFO - "slavebuilddir": "test" 16:23:29 INFO - } 16:23:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:23:29 INFO - Running post-action listener: _resource_record_post_action 16:23:29 INFO - [mozharness: 2016-08-21 23:23:29.680084Z] Finished read-buildbot-config step (success) 16:23:29 INFO - [mozharness: 2016-08-21 23:23:29.680173Z] Running download-and-extract step. 16:23:29 INFO - Running pre-action listener: _resource_record_pre_action 16:23:29 INFO - Running main action method: download_and_extract 16:23:29 INFO - mkdir: /builds/slave/test/build/tests 16:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:29 INFO - trying https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:23:29 INFO - Downloading https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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 16:23:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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 16:23:30 INFO - Downloaded 1361 bytes. 16:23:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:23:30 INFO - Using the following test package requirements: 16:23:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:23:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:23:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:23:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:30 INFO - u'jsshell-linux-x86_64.zip'], 16:23:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:23:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:23:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:23:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:23:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:23:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:23:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:23:30 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')]} 16:23:30 INFO - trying https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:23:30 INFO - Downloading https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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 16:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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 16:23:31 INFO - Downloaded 21921208 bytes. 16:23:31 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 16:23:35 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 16:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:35 INFO - trying https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:23:35 INFO - Downloading https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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 16:23:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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 16:23:36 INFO - Downloaded 21921208 bytes. 16:23:36 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 16:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:40 INFO - trying https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:23:40 INFO - Downloading https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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 16:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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 16:23:41 INFO - Downloaded 14413981 bytes. 16:23:41 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 16:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:41 INFO - trying https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:23:41 INFO - Downloading https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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 16:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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 16:23:43 INFO - Downloaded 59698686 bytes. 16:23:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:23:43 INFO - mkdir: /builds/slave/test/properties 16:23:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:23:43 INFO - Writing to file /builds/slave/test/properties/build_url 16:23:43 INFO - Contents: 16:23:43 INFO - build_url:https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:23:44 INFO - Running post-action listener: _resource_record_post_action 16:23:44 INFO - Running post-action listener: set_extra_try_arguments 16:23:44 INFO - [mozharness: 2016-08-21 23:23:44.144869Z] Finished download-and-extract step (success) 16:23:44 INFO - [mozharness: 2016-08-21 23:23:44.145133Z] Running populate-webroot step. 16:23:44 INFO - Running pre-action listener: _resource_record_pre_action 16:23:44 INFO - Running main action method: populate_webroot 16:23:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:23:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:23:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:23:44 INFO - '--tppagecycles', 16:23:44 INFO - '7'], 16:23:44 INFO - 'tests': ['tsvgm']}}, 16:23:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:23:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:23:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:23:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:23:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:44 INFO - 'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:44 INFO - 'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['damp', 'tps']}, 16:23:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:44 INFO - 'tests': ['damp', 'tps']}, 16:23:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['dromaeo_dom']}, 16:23:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:23:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['basic_compositor_video']}, 16:23:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:23:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['a11yr', 16:23:44 INFO - 'ts_paint', 16:23:44 INFO - 'tpaint', 16:23:44 INFO - 'sessionrestore', 16:23:44 INFO - 'sessionrestore_no_auto_restore', 16:23:44 INFO - 'tabpaint']}, 16:23:44 INFO - 'other-e10s': {'tests': ['a11yr', 16:23:44 INFO - 'ts_paint', 16:23:44 INFO - 'tpaint', 16:23:44 INFO - 'sessionrestore', 16:23:44 INFO - 'sessionrestore_no_auto_restore', 16:23:44 INFO - 'tabpaint']}, 16:23:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:23:44 INFO - 'ts_paint', 16:23:44 INFO - 'tpaint', 16:23:44 INFO - 'sessionrestore', 16:23:44 INFO - 'sessionrestore_no_auto_restore', 16:23:44 INFO - 'tabpaint']}, 16:23:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:23:44 INFO - 'ts_paint', 16:23:44 INFO - 'tpaint', 16:23:44 INFO - 'sessionrestore', 16:23:44 INFO - 'sessionrestore_no_auto_restore', 16:23:44 INFO - 'tabpaint']}, 16:23:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['a11yr', 16:23:44 INFO - 'ts_paint', 16:23:44 INFO - 'tpaint', 16:23:44 INFO - 'sessionrestore', 16:23:44 INFO - 'sessionrestore_no_auto_restore', 16:23:44 INFO - 'tabpaint']}, 16:23:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['a11yr', 16:23:44 INFO - 'ts_paint', 16:23:44 INFO - 'tpaint', 16:23:44 INFO - 'sessionrestore', 16:23:44 INFO - 'sessionrestore_no_auto_restore', 16:23:44 INFO - 'tabpaint']}, 16:23:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['tsvgx', 16:23:44 INFO - 'tsvgr_opacity', 16:23:44 INFO - 'tart', 16:23:44 INFO - 'tscrollx', 16:23:44 INFO - 'cart']}, 16:23:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:23:44 INFO - 'tsvgr_opacity', 16:23:44 INFO - 'tart', 16:23:44 INFO - 'tscrollx', 16:23:44 INFO - 'cart']}, 16:23:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:44 INFO - 'talos_options': ['--disable-e10s'], 16:23:44 INFO - 'tests': ['tp5o']}, 16:23:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:44 INFO - 'tests': ['tp5o']}, 16:23:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:44 INFO - 'talos_options': ['--disable-e10s', 16:23:44 INFO - '--xperf_path', 16:23:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:44 INFO - 'tests': ['tp5n']}, 16:23:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:44 INFO - 'talos_options': ['--xperf_path', 16:23:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:44 INFO - 'tests': ['tp5n']}}, 16:23:44 INFO - 'talos.zip': {'path': '', 16:23:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:23:44 INFO - Running post-action listener: _resource_record_post_action 16:23:44 INFO - [mozharness: 2016-08-21 23:23:44.165970Z] Finished populate-webroot step (success) 16:23:44 INFO - [mozharness: 2016-08-21 23:23:44.166072Z] Running create-virtualenv step. 16:23:44 INFO - Running pre-action listener: _resource_record_pre_action 16:23:44 INFO - Running main action method: create_virtualenv 16:23:44 INFO - Creating virtualenv /builds/slave/test/build/venv 16:23:44 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 16:23:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:23:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:23:44 INFO - Using real prefix '/usr' 16:23:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:23:44 INFO - Installing distribute.............................................................................................................................................................................................done. 16:23:46 INFO - Installing pip.................done. 16:23:46 INFO - Return code: 0 16:23:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08db702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, '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': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', '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 16:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:23:46 INFO - Using env: {'DISPLAY': ':0', 16:23:46 INFO - 'HOME': '/home/cltbld', 16:23:46 INFO - 'LANG': 'en_US.UTF-8', 16:23:46 INFO - 'LANGUAGE': 'en_US:en', 16:23:46 INFO - 'LOGNAME': 'cltbld', 16:23:46 INFO - 'MAIL': '/var/mail/cltbld', 16:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:46 INFO - 'MOZ_NO_REMOTE': '1', 16:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:46 INFO - 'NO_EM_RESTART': '1', 16:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:46 INFO - 'PWD': '/builds/slave/test', 16:23:46 INFO - 'SHELL': '/bin/bash', 16:23:46 INFO - 'SHLVL': '1', 16:23:46 INFO - 'TERM': 'linux', 16:23:46 INFO - 'TMOUT': '86400', 16:23:46 INFO - 'USER': 'cltbld', 16:23:46 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:46 INFO - '_': '/tools/buildbot/bin/python'} 16:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:46 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 16:23:46 INFO - Cleaning up... 16:23:46 INFO - Return code: 0 16:23:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f08db702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, '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': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', '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 16:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:23:46 INFO - Using env: {'DISPLAY': ':0', 16:23:46 INFO - 'HOME': '/home/cltbld', 16:23:46 INFO - 'LANG': 'en_US.UTF-8', 16:23:46 INFO - 'LANGUAGE': 'en_US:en', 16:23:46 INFO - 'LOGNAME': 'cltbld', 16:23:46 INFO - 'MAIL': '/var/mail/cltbld', 16:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:46 INFO - 'MOZ_NO_REMOTE': '1', 16:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:46 INFO - 'NO_EM_RESTART': '1', 16:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:46 INFO - 'PWD': '/builds/slave/test', 16:23:46 INFO - 'SHELL': '/bin/bash', 16:23:46 INFO - 'SHLVL': '1', 16:23:46 INFO - 'TERM': 'linux', 16:23:46 INFO - 'TMOUT': '86400', 16:23:46 INFO - 'USER': 'cltbld', 16:23:46 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:46 INFO - '_': '/tools/buildbot/bin/python'} 16:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:47 INFO - Downloading/unpacking psutil>=3.1.1 16:23:47 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 16:23:47 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 16:23:47 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 16:23:47 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 16:23:47 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 16:23:47 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 16:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:23:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:49 INFO - Installing collected packages: psutil 16:23:49 INFO - Running setup.py install for psutil 16:23:49 INFO - building 'psutil._psutil_linux' extension 16:23:49 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 16:23:49 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 16:23:49 INFO - building 'psutil._psutil_posix' extension 16:23:49 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 16:23:49 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 16:23:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:49 INFO - Successfully installed psutil 16:23:49 INFO - Cleaning up... 16:23:49 INFO - Return code: 0 16:23:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:49 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 0x7f08db702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, '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': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', '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 16:23:49 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 16:23:49 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 16:23:49 INFO - Using env: {'DISPLAY': ':0', 16:23:49 INFO - 'HOME': '/home/cltbld', 16:23:49 INFO - 'LANG': 'en_US.UTF-8', 16:23:49 INFO - 'LANGUAGE': 'en_US:en', 16:23:49 INFO - 'LOGNAME': 'cltbld', 16:23:49 INFO - 'MAIL': '/var/mail/cltbld', 16:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:49 INFO - 'MOZ_NO_REMOTE': '1', 16:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:49 INFO - 'NO_EM_RESTART': '1', 16:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:49 INFO - 'PWD': '/builds/slave/test', 16:23:49 INFO - 'SHELL': '/bin/bash', 16:23:49 INFO - 'SHLVL': '1', 16:23:49 INFO - 'TERM': 'linux', 16:23:49 INFO - 'TMOUT': '86400', 16:23:49 INFO - 'USER': 'cltbld', 16:23:49 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:49 INFO - '_': '/tools/buildbot/bin/python'} 16:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:23:49 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 16:23:49 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 16:23:49 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 16:23:49 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 16:23:49 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 16:23:49 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 16:23:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:23:51 INFO - Installing collected packages: mozsystemmonitor 16:23:51 INFO - Running setup.py install for mozsystemmonitor 16:23:51 INFO - Successfully installed mozsystemmonitor 16:23:51 INFO - Cleaning up... 16:23:51 INFO - Return code: 0 16:23:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:23:51 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')]} 16:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:51 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')]} 16:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:51 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 0x7f08db702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, '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': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', '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 16:23:51 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 16:23:51 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 16:23:52 INFO - Using env: {'DISPLAY': ':0', 16:23:52 INFO - 'HOME': '/home/cltbld', 16:23:52 INFO - 'LANG': 'en_US.UTF-8', 16:23:52 INFO - 'LANGUAGE': 'en_US:en', 16:23:52 INFO - 'LOGNAME': 'cltbld', 16:23:52 INFO - 'MAIL': '/var/mail/cltbld', 16:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:52 INFO - 'MOZ_NO_REMOTE': '1', 16:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:52 INFO - 'NO_EM_RESTART': '1', 16:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:52 INFO - 'PWD': '/builds/slave/test', 16:23:52 INFO - 'SHELL': '/bin/bash', 16:23:52 INFO - 'SHLVL': '1', 16:23:52 INFO - 'TERM': 'linux', 16:23:52 INFO - 'TMOUT': '86400', 16:23:52 INFO - 'USER': 'cltbld', 16:23:52 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:52 INFO - '_': '/tools/buildbot/bin/python'} 16:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:52 INFO - Downloading/unpacking jsonschema==2.5.1 16:23:52 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 16:23:52 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 16:23:52 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 16:23:52 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 16:23:52 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 16:23:52 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 16:23:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:23:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:23:54 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 16:23:54 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 16:23:54 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 16:23:54 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 16:23:54 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 16:23:54 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 16:23:54 INFO - Downloading functools32-3.2.3-2.tar.gz 16:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:23:54 INFO - warning: no files found matching '*.txt' 16:23:54 INFO - no previously-included directories found matching 'build' 16:23:54 INFO - no previously-included directories found matching 'dist' 16:23:54 INFO - no previously-included directories found matching '.git*' 16:23:54 INFO - Installing collected packages: jsonschema, functools32 16:23:54 INFO - Running setup.py install for functools32 16:23:54 INFO - warning: no files found matching '*.txt' 16:23:54 INFO - no previously-included directories found matching 'build' 16:23:54 INFO - no previously-included directories found matching 'dist' 16:23:54 INFO - no previously-included directories found matching '.git*' 16:23:54 INFO - Successfully installed jsonschema functools32 16:23:54 INFO - Cleaning up... 16:23:54 INFO - Return code: 0 16:23:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:23:54 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')]} 16:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:54 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')]} 16:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:54 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 0x7f08db702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, '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': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', '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 16:23:54 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 16:23:54 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 16:23:54 INFO - Using env: {'DISPLAY': ':0', 16:23:54 INFO - 'HOME': '/home/cltbld', 16:23:54 INFO - 'LANG': 'en_US.UTF-8', 16:23:54 INFO - 'LANGUAGE': 'en_US:en', 16:23:54 INFO - 'LOGNAME': 'cltbld', 16:23:54 INFO - 'MAIL': '/var/mail/cltbld', 16:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:54 INFO - 'MOZ_NO_REMOTE': '1', 16:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:54 INFO - 'NO_EM_RESTART': '1', 16:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:54 INFO - 'PWD': '/builds/slave/test', 16:23:54 INFO - 'SHELL': '/bin/bash', 16:23:54 INFO - 'SHLVL': '1', 16:23:54 INFO - 'TERM': 'linux', 16:23:54 INFO - 'TMOUT': '86400', 16:23:54 INFO - 'USER': 'cltbld', 16:23:54 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:54 INFO - '_': '/tools/buildbot/bin/python'} 16:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:23:54 INFO - Cleaning up... 16:23:54 INFO - Return code: 0 16:23:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:23:54 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')]} 16:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:54 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')]} 16:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:54 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 0x7f08db702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, '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': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', '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 16:23:54 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 16:23:54 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 16:23:54 INFO - Using env: {'DISPLAY': ':0', 16:23:54 INFO - 'HOME': '/home/cltbld', 16:23:54 INFO - 'LANG': 'en_US.UTF-8', 16:23:54 INFO - 'LANGUAGE': 'en_US:en', 16:23:54 INFO - 'LOGNAME': 'cltbld', 16:23:54 INFO - 'MAIL': '/var/mail/cltbld', 16:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:54 INFO - 'MOZ_NO_REMOTE': '1', 16:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:54 INFO - 'NO_EM_RESTART': '1', 16:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:54 INFO - 'PWD': '/builds/slave/test', 16:23:54 INFO - 'SHELL': '/bin/bash', 16:23:54 INFO - 'SHLVL': '1', 16:23:54 INFO - 'TERM': 'linux', 16:23:54 INFO - 'TMOUT': '86400', 16:23:54 INFO - 'USER': 'cltbld', 16:23:54 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:54 INFO - '_': '/tools/buildbot/bin/python'} 16:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:54 INFO - Downloading/unpacking blobuploader==1.2.4 16:23:54 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 16:23:54 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 16:23:54 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 16:23:54 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 16:23:54 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 16:23:54 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 16:23:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:23:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:23:57 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 16:23:57 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 16:23:57 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 16:23:57 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 16:23:57 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 16:23:57 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 16:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:23:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:23:57 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 16:23:57 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 16:23:57 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 16:23:57 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 16:23:57 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 16:23:57 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 16:23:57 INFO - Downloading docopt-0.6.1.tar.gz 16:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:23:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:23:57 INFO - Running setup.py install for blobuploader 16:23:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:23:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:23:57 INFO - Running setup.py install for requests 16:23:58 INFO - Running setup.py install for docopt 16:23:58 INFO - Successfully installed blobuploader requests docopt 16:23:58 INFO - Cleaning up... 16:23:58 INFO - Return code: 0 16:23:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:58 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')]} 16:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:58 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')]} 16:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:58 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 0x7f08db702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, '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': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', '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 16:23:58 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 16:23:58 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 16:23:58 INFO - Using env: {'DISPLAY': ':0', 16:23:58 INFO - 'HOME': '/home/cltbld', 16:23:58 INFO - 'LANG': 'en_US.UTF-8', 16:23:58 INFO - 'LANGUAGE': 'en_US:en', 16:23:58 INFO - 'LOGNAME': 'cltbld', 16:23:58 INFO - 'MAIL': '/var/mail/cltbld', 16:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:58 INFO - 'MOZ_NO_REMOTE': '1', 16:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:58 INFO - 'NO_EM_RESTART': '1', 16:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:58 INFO - 'PWD': '/builds/slave/test', 16:23:58 INFO - 'SHELL': '/bin/bash', 16:23:58 INFO - 'SHLVL': '1', 16:23:58 INFO - 'TERM': 'linux', 16:23:58 INFO - 'TMOUT': '86400', 16:23:58 INFO - 'USER': 'cltbld', 16:23:58 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:58 INFO - '_': '/tools/buildbot/bin/python'} 16:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:58 INFO - Running setup.py (path:/tmp/pip-VzDiYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:58 INFO - Running setup.py (path:/tmp/pip-XR_Peh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:58 INFO - Running setup.py (path:/tmp/pip-LQ2Na_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:58 INFO - Running setup.py (path:/tmp/pip-_FEhys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:58 INFO - Running setup.py (path:/tmp/pip-m__3s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:58 INFO - Running setup.py (path:/tmp/pip-n1Ezs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:58 INFO - Running setup.py (path:/tmp/pip-jKPd_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:59 INFO - Running setup.py (path:/tmp/pip-wUk0K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:59 INFO - Running setup.py (path:/tmp/pip-QbJLT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:59 INFO - Running setup.py (path:/tmp/pip-agx9j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:59 INFO - Running setup.py (path:/tmp/pip-NumZ9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:59 INFO - Running setup.py (path:/tmp/pip-_3RE80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:59 INFO - Running setup.py (path:/tmp/pip-ZfJOr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:59 INFO - Running setup.py (path:/tmp/pip-_KR3fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:59 INFO - Running setup.py (path:/tmp/pip-usIDkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:59 INFO - Running setup.py (path:/tmp/pip-VUj4HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:59 INFO - Running setup.py (path:/tmp/pip-TdxrZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:23:59 INFO - Running setup.py install for manifestparser 16:23:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:23:59 INFO - Running setup.py install for mozcrash 16:23:59 INFO - Running setup.py install for mozdebug 16:24:00 INFO - Running setup.py install for mozdevice 16:24:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for mozfile 16:24:00 INFO - Running setup.py install for mozhttpd 16:24:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for mozinfo 16:24:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for mozInstall 16:24:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for mozleak 16:24:00 INFO - Running setup.py install for mozlog 16:24:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for moznetwork 16:24:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for mozprocess 16:24:00 INFO - Running setup.py install for mozprofile 16:24:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:24:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:24:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:24:01 INFO - Running setup.py install for mozrunner 16:24:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:24:01 INFO - Running setup.py install for mozscreenshot 16:24:01 INFO - Running setup.py install for moztest 16:24:01 INFO - Running setup.py install for mozversion 16:24:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:24:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:24:01 INFO - Cleaning up... 16:24:01 INFO - Return code: 0 16:24:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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')]} 16:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:01 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 0x7f08db702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, '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': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', '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 16:24:01 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 16:24:01 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 16:24:01 INFO - Using env: {'DISPLAY': ':0', 16:24:01 INFO - 'HOME': '/home/cltbld', 16:24:01 INFO - 'LANG': 'en_US.UTF-8', 16:24:01 INFO - 'LANGUAGE': 'en_US:en', 16:24:01 INFO - 'LOGNAME': 'cltbld', 16:24:01 INFO - 'MAIL': '/var/mail/cltbld', 16:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:01 INFO - 'MOZ_NO_REMOTE': '1', 16:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:01 INFO - 'NO_EM_RESTART': '1', 16:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:01 INFO - 'PWD': '/builds/slave/test', 16:24:01 INFO - 'SHELL': '/bin/bash', 16:24:01 INFO - 'SHLVL': '1', 16:24:01 INFO - 'TERM': 'linux', 16:24:01 INFO - 'TMOUT': '86400', 16:24:01 INFO - 'USER': 'cltbld', 16:24:01 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:01 INFO - '_': '/tools/buildbot/bin/python'} 16:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:01 INFO - Running setup.py (path:/tmp/pip-o5b_8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:01 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)) 16:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:01 INFO - Running setup.py (path:/tmp/pip-z7MjRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:01 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)) 16:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:01 INFO - Running setup.py (path:/tmp/pip-TpfN4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:01 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)) 16:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:01 INFO - Running setup.py (path:/tmp/pip-23vGBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:02 INFO - Running setup.py (path:/tmp/pip-kN3B3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:02 INFO - Running setup.py (path:/tmp/pip-ssbwNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:02 INFO - Running setup.py (path:/tmp/pip-kx_3FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:02 INFO - Running setup.py (path:/tmp/pip-SnUGzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:02 INFO - Running setup.py (path:/tmp/pip-1xoHKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:02 INFO - Running setup.py (path:/tmp/pip-wAXFd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:02 INFO - Running setup.py (path:/tmp/pip-jThX9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:02 INFO - Running setup.py (path:/tmp/pip-rClnwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:02 INFO - Running setup.py (path:/tmp/pip-F24rRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:02 INFO - Running setup.py (path:/tmp/pip-ynF7sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:02 INFO - Running setup.py (path:/tmp/pip-etK5fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:02 INFO - Running setup.py (path:/tmp/pip-U0_3m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:02 INFO - Running setup.py (path:/tmp/pip-M3B85a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:03 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)) 16:24:03 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)) 16:24:03 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)) 16:24:03 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)) 16:24:03 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)) 16:24:03 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)) 16:24:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:24:03 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 16:24:03 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 16:24:03 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 16:24:03 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 16:24:03 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 16:24:03 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 16:24:04 INFO - Downloading blessings-1.6.tar.gz 16:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:24:04 INFO - Installing collected packages: blessings 16:24:04 INFO - Running setup.py install for blessings 16:24:05 INFO - Successfully installed blessings 16:24:05 INFO - Cleaning up... 16:24:05 INFO - Return code: 0 16:24:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:24:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:05 INFO - Reading from file tmpfile_stdout 16:24:05 INFO - Current package versions: 16:24:05 INFO - argparse == 1.2.1 16:24:05 INFO - blessings == 1.6 16:24:05 INFO - blobuploader == 1.2.4 16:24:05 INFO - docopt == 0.6.1 16:24:05 INFO - functools32 == 3.2.3-2 16:24:05 INFO - jsonschema == 2.5.1 16:24:05 INFO - manifestparser == 1.1 16:24:05 INFO - mozInstall == 1.12 16:24:05 INFO - mozcrash == 0.17 16:24:05 INFO - mozdebug == 0.1 16:24:05 INFO - mozdevice == 0.48 16:24:05 INFO - mozfile == 1.2 16:24:05 INFO - mozhttpd == 0.7 16:24:05 INFO - mozinfo == 0.9 16:24:05 INFO - mozleak == 0.1 16:24:05 INFO - mozlog == 3.3 16:24:05 INFO - moznetwork == 0.27 16:24:05 INFO - mozprocess == 0.23 16:24:05 INFO - mozprofile == 0.28 16:24:05 INFO - mozrunner == 6.12 16:24:05 INFO - mozscreenshot == 0.1 16:24:05 INFO - mozsystemmonitor == 0.3 16:24:05 INFO - moztest == 0.7 16:24:05 INFO - mozversion == 1.4 16:24:05 INFO - psutil == 3.1.1 16:24:05 INFO - requests == 1.2.3 16:24:05 INFO - wsgiref == 0.1.2 16:24:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:05 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')]} 16:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:05 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')]} 16:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:05 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 0x7f08db702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, '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': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', '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 16:24:05 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 16:24:05 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 16:24:05 INFO - Using env: {'DISPLAY': ':0', 16:24:05 INFO - 'HOME': '/home/cltbld', 16:24:05 INFO - 'LANG': 'en_US.UTF-8', 16:24:05 INFO - 'LANGUAGE': 'en_US:en', 16:24:05 INFO - 'LOGNAME': 'cltbld', 16:24:05 INFO - 'MAIL': '/var/mail/cltbld', 16:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:05 INFO - 'MOZ_NO_REMOTE': '1', 16:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:05 INFO - 'NO_EM_RESTART': '1', 16:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:05 INFO - 'PWD': '/builds/slave/test', 16:24:05 INFO - 'SHELL': '/bin/bash', 16:24:05 INFO - 'SHLVL': '1', 16:24:05 INFO - 'TERM': 'linux', 16:24:05 INFO - 'TMOUT': '86400', 16:24:05 INFO - 'USER': 'cltbld', 16:24:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:05 INFO - '_': '/tools/buildbot/bin/python'} 16:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:05 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)) 16:24:05 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)) 16:24:05 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)) 16:24:05 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)) 16:24:05 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)) 16:24:05 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)) 16:24:05 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)) 16:24:05 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)) 16:24:05 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)) 16:24:05 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)) 16:24:05 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)) 16:24:05 INFO - Cleaning up... 16:24:05 INFO - Return code: 0 16:24:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:24:05 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')]} 16:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:05 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')]} 16:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:05 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 0x7f08db702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, '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': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', '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 16:24:05 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 16:24:05 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 16:24:05 INFO - Using env: {'DISPLAY': ':0', 16:24:05 INFO - 'HOME': '/home/cltbld', 16:24:05 INFO - 'LANG': 'en_US.UTF-8', 16:24:05 INFO - 'LANGUAGE': 'en_US:en', 16:24:05 INFO - 'LOGNAME': 'cltbld', 16:24:05 INFO - 'MAIL': '/var/mail/cltbld', 16:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:05 INFO - 'MOZ_NO_REMOTE': '1', 16:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:05 INFO - 'NO_EM_RESTART': '1', 16:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:05 INFO - 'PWD': '/builds/slave/test', 16:24:05 INFO - 'SHELL': '/bin/bash', 16:24:05 INFO - 'SHLVL': '1', 16:24:05 INFO - 'TERM': 'linux', 16:24:05 INFO - 'TMOUT': '86400', 16:24:05 INFO - 'USER': 'cltbld', 16:24:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:05 INFO - '_': '/tools/buildbot/bin/python'} 16:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:24:05 INFO - Cleaning up... 16:24:05 INFO - Return code: 0 16:24:05 INFO - Running post-action listener: _resource_record_post_action 16:24:05 INFO - Running post-action listener: _start_resource_monitoring 16:24:05 INFO - Starting resource monitoring. 16:24:05 INFO - [mozharness: 2016-08-21 23:24:05.831816Z] Finished create-virtualenv step (success) 16:24:05 INFO - [mozharness: 2016-08-21 23:24:05.832323Z] Running install step. 16:24:05 INFO - Running pre-action listener: _resource_record_pre_action 16:24:05 INFO - Running main action method: install 16:24:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:06 INFO - Reading from file tmpfile_stdout 16:24:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:24:06 INFO - Reading from file tmpfile_stdout 16:24:06 INFO - Output received: 16:24:06 INFO - Usage: mozinstall [options] installer 16:24:06 INFO - Options: 16:24:06 INFO - -h, --help show this help message and exit 16:24:06 INFO - -d DEST, --destination=DEST 16:24:06 INFO - Directory to install application into. [default: 16:24:06 INFO - "/builds/slave/test"] 16:24:06 INFO - --app=APP Application being installed. [default: firefox] 16:24:06 INFO - mkdir: /builds/slave/test/build/application 16:24:06 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'] 16:24:06 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 16:24:23 INFO - Reading from file tmpfile_stdout 16:24:23 INFO - Output received: 16:24:23 INFO - /builds/slave/test/build/application/firefox/firefox 16:24:23 INFO - Running post-action listener: _resource_record_post_action 16:24:23 INFO - [mozharness: 2016-08-21 23:24:23.384930Z] Finished install step (success) 16:24:23 INFO - [mozharness: 2016-08-21 23:24:23.385187Z] Running run-tests step. 16:24:23 INFO - Running pre-action listener: _resource_record_pre_action 16:24:23 INFO - Running main action method: run_tests 16:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:24:23 INFO - Python 2.7.3 16:24:23 INFO - Return code: 0 16:24:23 INFO - grabbing minidump binary from tooltool 16:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:23 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 0x1f87090>, '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 0x1f8a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ae40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:24:23 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 16:24:23 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 16:24:23 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 16:24:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:24:23 INFO - Return code: 0 16:24:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:24:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:24:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:24:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:24:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 16:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 16:24:23 INFO - Using env: {'DISPLAY': ':0', 16:24:23 INFO - 'HOME': '/home/cltbld', 16:24:23 INFO - 'LANG': 'en_US.UTF-8', 16:24:23 INFO - 'LANGUAGE': 'en_US:en', 16:24:23 INFO - 'LOGNAME': 'cltbld', 16:24:23 INFO - 'MAIL': '/var/mail/cltbld', 16:24:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:24:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:23 INFO - 'MOZ_NO_REMOTE': '1', 16:24:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:23 INFO - 'NO_EM_RESTART': '1', 16:24:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:23 INFO - 'PWD': '/builds/slave/test', 16:24:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:24:23 INFO - 'SHELL': '/bin/bash', 16:24:23 INFO - 'SHLVL': '1', 16:24:23 INFO - 'TERM': 'linux', 16:24:23 INFO - 'TMOUT': '86400', 16:24:23 INFO - 'USER': 'cltbld', 16:24:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656', 16:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:23 INFO - '_': '/tools/buildbot/bin/python'} 16:24:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 16:24:23 INFO - mozversion application_buildid: 20160821133003 16:24:23 INFO - mozversion application_changeset: f823117225343b73be4df1ee89c904580d66d148 16:24:23 INFO - mozversion application_display_name: Nightly 16:24:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:24:23 INFO - mozversion application_name: Firefox 16:24:23 INFO - mozversion application_remotingname: firefox 16:24:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:24:23 INFO - mozversion application_vendor: Mozilla 16:24:23 INFO - mozversion application_version: 51.0a1 16:24:23 INFO - mozversion platform_buildid: 20160821133003 16:24:23 INFO - mozversion platform_changeset: f823117225343b73be4df1ee89c904580d66d148 16:24:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:24:23 INFO - mozversion platform_version: 51.0a1 16:24:23 INFO - using testdate: 1471821863 16:24:23 INFO - actual date: 1471821863 16:24:23 INFO - starting webserver on 'localhost:53402' 16:24:23 INFO - SUITE-START | Running 2 tests 16:24:23 INFO - TEST-START | dromaeo_css 16:24:23 INFO - operating with platform_type : linux_ 16:24:23 INFO - Initialising browser for dromaeo_css test... 16:24:23 INFO - TEST-INFO | started process 17170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmporQTZL/profile http://localhost:53402/getInfo.html) 16:24:28 INFO - PROCESS | 17170 | __metrics Screen width/height:1600/1200 16:24:28 INFO - PROCESS | 17170 | colorDepth:24 16:24:28 INFO - PROCESS | 17170 | Browser inner width/height: 1024/697 16:24:28 INFO - PROCESS | 17170 | __metrics 16:24:28 INFO - PROCESS | 17170 | 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" 16:24:28 INFO - PROCESS | 17170 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:24:29 INFO - PROCESS | 17170 | console.error: PushService: 16:24:29 INFO - PROCESS | 17170 | stateChangeProcessEnqueue: Error transitioning state 16:24:29 INFO - PROCESS | 17170 | UnknownError 16:24:30 INFO - TEST-INFO | 17170: exit 0 16:24:30 INFO - Browser initialized. 16:24:30 INFO - Running cycle 1/1 for dromaeo_css test... 16:24:30 INFO - TEST-INFO | started process 17254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmporQTZL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:42 INFO - PROCESS | 17254 | RSS: Main: 173613056 16:24:42 INFO - PROCESS | 17254 | 16:25:33 INFO - PROCESS | 17254 | 1471821933498 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] 16:27:42 INFO - PROCESS | 17254 | Cycle 1(1): loaded http://localhost:53402/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53402/tests/dromaeo/cssquery-ext.html) 16:27:43 INFO - PROCESS | 17254 | RSS: Main: 280801280 16:27:43 INFO - PROCESS | 17254 | 16:30:46 INFO - PROCESS | 17254 | Cycle 1(1): loaded http://localhost:53402/tests/dromaeo/cssquery-ext.html (next: http://localhost:53402/tests/dromaeo/cssquery-jquery.html) 16:30:46 INFO - PROCESS | 17254 | RSS: Main: 269393920 16:30:46 INFO - PROCESS | 17254 | 16:33:49 INFO - PROCESS | 17254 | Cycle 1(1): loaded http://localhost:53402/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53402/tests/dromaeo/cssquery-mootools.html) 16:33:49 INFO - PROCESS | 17254 | RSS: Main: 253407232 16:33:49 INFO - PROCESS | 17254 | 16:36:51 INFO - PROCESS | 17254 | Cycle 1(1): loaded http://localhost:53402/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53402/tests/dromaeo/cssquery-prototype.html) 16:36:52 INFO - PROCESS | 17254 | RSS: Main: 249094144 16:36:52 INFO - PROCESS | 17254 | 16:39:55 INFO - PROCESS | 17254 | Cycle 1(1): loaded http://localhost:53402/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53402/tests/dromaeo/cssquery-yui.html) 16:39:55 INFO - PROCESS | 17254 | RSS: Main: 216653824 16:39:55 INFO - PROCESS | 17254 | 16:42:58 INFO - PROCESS | 17254 | Cycle 1(1): loaded http://localhost:53402/tests/dromaeo/cssquery-yui.html (next: http://localhost:53402/tests/dromaeo/cssquery-dojo.html) 16:42:59 INFO - PROCESS | 17254 | RSS: Main: 306102272 16:42:59 INFO - PROCESS | 17254 | 16:42:59 INFO - PROCESS | 17254 | __start_tp_report 16:42:59 INFO - PROCESS | 17254 | _x_x_mozilla_page_load 16:42:59 INFO - PROCESS | 17254 | _x_x_mozilla_page_load_details 16:42:59 INFO - PROCESS | 17254 | |i|pagename|runs| 16:42:59 INFO - PROCESS | 17254 | |0;dojo.html;2883.336832528517;2932.1057077591327;2958.1273524310327;2966.777491688123;3012.1114271289975;5189.117849965505;5207;5253.763580638871;5357.08929481988;5396.703181325026;5260.579153667707;5276.261323414725;5280.973595132019;5286.814961476349;5389.272448219489;4782.569568738812;4818.469968303492;4932.309476673268;4973.452920178777;4978.427480839696;4970.701757894538;4983.676061056038;5003.624728145385;5009;5011.624128190382;4749.382580264543;4780.545848144421;4796.544328288807;4910.091633047879;4928.728919909404;4732.692374995614;4766.332713420124;4767.713937163781;4770.594499467549;4777.0445910817625;4715.221988371914;4729.101470720552;4804.015176888729;4804.495527969582;4819.987802561466;5140.640155189139;5288.788448462057;5300.257963885059;5304.655197412195;5306.442823503554;5654.067078931971;5677.687727175004;5683.857903552403;5754.827355179351;5761;5743.798967036176;5776.913346299809;5793.594448388572;5800.4489573490455;5801.100829371412;5160.948390516121;5261.447548007481;5398.163284690879;5401.891962160774;5403.648762830403;5804.506616937523;5911.113333000085;5912.733926973297;5917.467427931507;5919.526437884959;5650.915236271459;5655.406182350876;5657.858553536194;5664.376918538957;5664.49019588239;5576.832695019156;5612.719364031782;5734.942650573525;5748.080307150919;5752.3097228332035;5650.180723795109;5737.942620573825;5741.712914354349;5743.2246646703;5748.511376532958;5721.599488035881;5749.683767392834;5756.0502517084215;5758.798442054508;5764.682942438206;4264.829406823755;4355.956440435555;4432.800523976429;4438.911221775546;4439.067795762926;3898.7855667938534;3921.529416469985;3922.4508568800393;3931.64615184629;3947.17109407022;5491.478309560585;5493.285872836505;5493.423190564933;5497.340319161646;5501.092319767194;5523.7790488380815;5549.445055494499;5776.595638305278;5805.7387417566315;5818.156367326714;5372.221027951004;5439.728013599304;5456.590755693339;5458.9454105458435;5477.123660214426;5025.623078269145;5028.949710502849;5030.748462576857;5036.043151801219;5037.974810125999;5787.565932555075;5880.852978675567;5934.19888315072;5939.792107276225;5944.346121926585;5707.7716891325545;5780.826575202751;5805.883882322414;5806.361300257053;5809.331926828299;5986.910196346971;5999.5800293979;6004.0693692477735;6018.518518518596;6023.427774361428;5452.100403433389;5595.63628364155;5631.549476041989;5709.314882214161;5711.343195532567;5740.253767010262;5802;5836.678982655825;5836.970815145897;5841.211436456024;5671.744771485211;5685.232493613309;5685.971570142123;5687.9431205687415;5688.63023903445;5441.428649991693;5530.391656917655;5683.545316374597;5693.772249110155;5695.45893140151;5496.148097044965;5589.161625756169;5593.300837395325;5596;5604.075327570905;5683;5704.714764261687;5705.686187259741;5706.258186435737;5708.058170401837;5469;5500.669959802424;5560.666360018412;5591.329040515164;5602.355729091207 16:42:59 INFO - PROCESS | 17254 | |1;ext.html;565.3244372974295;581.9648240965928;594.7124475510518;597.8983572792624;599.7121381736769;43468.782656086754;44363;44496;44575.55424445755;47985.28022079663;45489.31766023504;46019.53980460195;46045.539544604544;46051.76974115133;46064.769676151656;8866.379353445262;8980.32647551433;9025.458472491639;9025.638974441015;9026.323025773061;8769.298456123526;8874.511901845395;8876.068012858654;8891;8895.199432051115;9021.729348119534;9062.773430664252;9064.773380665503;9067.773305667379;9072.682456114037;8989;9006.59470323837;9008.234300084436;9012.41419307743;9022.14289642483;8872.778180545474;8909.955450222773;8925.866112008325;8926.821463570692;8957.731268061969;43381;43661.56338436607;43787.56212437899;43789.78105109454;43839.78080109611;3521.366154092262;3705.2589482103685;3778.6410291022307;3831.616838316174;4025.7383270087353;32843.17892052694;33132.83433582841;33239.3352132956;33381.16547086318;33400.83299583511;3609.657082577151;3720.7303544837628;3751.9437208441896;3810.5617853946874;3863.729538932276;374021;375626;375667.12166439265;379111;379883;56893;57013.42986570081;57446.425535744944;57463;57531.712341438026;59729.701351492964;59751.701241493516;59757;59785.40214597886;59833;15038.398464061534;15224.238788060775;15235.085894846345;15259.313330900137;15259.313330900137;11700.531978720755;11768.58809941648;11769.411529423494;11770.352630605228;11771.293722376513;15149.848501514844;15894.682106357808;15895;15918.9204053979;16123.919380403024;6392.808215753535;6463.353664633593;6466.450351720063;6572.737090516326;6653.334666533405;696.4101387773827;1030.7320096774893;1099.7305660113323;1104.3981030338484;1167.1538134852333;28044.29889252744;28355;28957.85521072381;29054.854725726236;29081;1065.621704294964;1090.8909607618225;1106.7011906785124;1116.9218154729092;1179.2452830188686;13926.58220253394;14784.279475982532;14933.687399857356;15118.546443606709;15134.697306054037;619133;624307;625214;625944.8702756457;627486;59849;59886.70056649689;59923;59992.400075999554;60040;1209.673388185185;1360.156702844243;1372.629390064697;1390.874821266091;1409.8872090232758;27591.172264832087;29136.125916222547;29375.559366609945;29631.85184074066;29659.851700741357;50786.23820642619;50836.237456438925;51010.74494627503;51119.233211501116;51370;430846;431707;432695;432746;433767;26847.731522684524;27412.314692132855;27542.5868611975;28668.856655716587;28805.85597072001;47343.00482908236;47813;47914.760426197645;48030.279545806145;48367.758161210375;40311;40729.1854162921;41498.79250603849;43019.56980430281;44515.554844451144;41877.79061104675;42788.14423711446;45885.541144589464;46141.30788038115;46208.768956156346;37880.24239515139;38560.6143938557;39030;39313.606863930996;39437.80281098576;42571.3614295792;45169.32246016247;45390.31914521351;46228;47003.76498117488;26677.199684009513;26860.731392685822;26977.730222697523;27058.72941270641;27136.18591442181 16:42:59 INFO - PROCESS | 17254 | |2;jquery.html;359.20436233742254;370.80903334782573;381.1329226010826;390.1514206600643;407.8103681787968;15427.305771240293;17530.38643647471;19159.137838797255;19954.900225498888;20284.391468255977;19144;19417.126229319678;19417.32039378622;20168.19327226909;20210.191592336327;5184.326037615124;5565.6660600364;5654.846054256777;5786.71066446676;5793.855153621172;5599.048161812481;5677.205191273225;5706.429357064302;5708.058170401879;5709.486146246837;5505.394406615269;5666.093425051992;5672.461116193955;5678.858028549278;5772.769089236425;5910.379410161957;5913.704314784265;5921.378255283198;5922.615030023035;5924.585279030491;5531.557475401958;5694.402087780806;5728.112142617901;5736.483716465538;5739;13830.585082447542;14190.645233869132;14195.290235488184;22041.338759837232;23822.285331440085;2222.244436891465;2304.8271379646426;2448.192096608133;2475.554400207962;2875.683674795771;10085.949570252102;10678;10728.249022568423;12634.936825315815;14384.424623015067;1858.4145994011842;1953.8925359105244;1971.2509246486386;2053.363457328218;2053.3839848045677;82671.586642067;83943;84383.57808210982;86294.56852715697;87836.56081719615;10983.835242471368;11065.889341106486;11114.722131946766;11177.44112794357;11287.49206285719;15338.923305383401;15352.385904563916;15362.231888405759;15364.846351536342;15384.846151538566;7612.657430415645;8009.838573406823;8022.518648881086;8238.8352232955;8241.95879020601;7335.596542190124;7419.777406677808;7519.323260906544;7550.093988721389;7829.530228186327;4535.569120933506;4615.215413379734;4659.603933665609;4809.062232864558;4831;1916.1951980168362;1936.7191757195128;1965.518447980254;1966;1988.6122206169657;851.9957400213083;925.9629614815332;980.4460479829016;984.886738025122;1055.5883205549842;17016.48950531486;17044.659106818042;18077.09614519269;18147.18337674808;18626.06869656512;969.8157350103598;989.1839232632963;1012.5342342522375;1018.7911478146962;1024.1192574386023;9111.27109831212;9749.171320437701;10092.142167915663;10141.29010969225;10179.592816287413;481116;492030;494939;501043;508674;89279;92409;92445;94307.52846235725;94354;981.6907674082784;998.9111868063845;1020.8009438159488;1023.2785885950387;1023.5291765787821;15537.300821463288;16132.435364762177;16157.353705851634;16188.838111619205;16375.67248655044;39570;41208.1758364837;43190.78404608082;43676.78161609299;44254.77872610616;58007.419925800205;58046.41953580579;59111;59264;59577;7988.480748751313;8272.296854767412;8424.368172387218;8492.915070849212;8764.76629439808;10268.58925642966;12781.105322627327;12815.16701414405;13085.934570327088;13118.409671564994;10661.360318380923;10689.30519516229;10760.246782725135;11167.25417161798;11175.441227938732;11086.113110951266;11198.496067677137;11209.831852522382;11272.549098035986;11761.176717629683;10671.092957098734;10793.838092428463;10928.836067459153;11156.609518667132;11350.829737553779;8073.636686349011;8204.876926845982;8303.294219991127;8338.624761885609;8490.490570565786;8078.609131303567;10597.25819192649;10631.202659800701;10757.784844303227;11111.111111111253 16:42:59 INFO - PROCESS | 17254 | |3;mootools.html;1286.6140157952611;1471.0511719940635;1513.2585033333667;1608.3807734022398;1755.4996825904611;8303.750887473378;8607.09625489324;8707.564621768903;9005.864912026309;9015.36892417531;9190.632374705005;9318.906810931889;9330.673426430076;9333.81332373352;9346.859797103049;2144.2280778919576;2436.3421876093444;2480.7643273889;2502.461970676304;2505.210858579551;2488.4027833320056;2515.157422263544;2522.697276326843;2524.835885667435;2531.50635626053;2430.987845060772;2448.7183973843057;2451.0318424222423;2487.502499500098;2496.400863792686;2390.8206884483734;2434.85390876548;2441.829071964963;2444.486657801855;2478.392793765539;2454.2882564056404;2464.236086813076;2475.405902583367;2476.3313905245664;2479.5164942836154;9454.669086581936;9537.761555961088;9596.568154433067;9645.807083858284;9655.758606034835;5467.343918729738;5602.523785478239;5620.353659329188;5620.887582248373;5628;3509.94735078974;3594.388953877847;3622.3479773640734;3692.40921452569;3702.9444558331647;1180.4510902430325;1187.7921363761393;1195.2888031621171;1212.6968257935516;1225.197495640357;12702;12769.0423218259;12815.102942794101;12843.229406235656;12855.421506032157;4463.866084017484;4641.605463535638;4753.215719406259;4848.0788650156355;4867.9269810952865;10067.597296108073;10128.898711012944;10266.384016959006;10302.948485257675;10303.072723454925;5349.251104845324;5349.465053494697;5352.892942141213;5360;5367.785288588413;4407.140607581555;4921.26181072842;4935.506449355035;4968.403791545038;5158.019976204584;3911.6283953024417;3939;4035.6569691576547;4035.6771458283265;4159.1265834175165;1064.0580939784923;1070.29895418501;1074.312440038376;1083.7940791249637;1114.9797934889484;844.7761343244046;856.8414843254018;885.4465958775766;941.8963913969458;962.5620342744174;5812.912806307909;5818.941810581925;5837.47462728348;5854.736536855852;6157.138000679908;935.209747763139;939.478589382899;964.2816102004052;1008.8839783425;1038.3406536849004;3901.6098390160755;4026.8791936241373;4043.5147782266317;4063.9390409143884;4095.3037983542868;11486.19596628228;11989.460474278678;11990;12015.699607509881;12018;11878.643640690792;11879.643610691694;11885.465154068088;11891.345975971231;11894.226875253082;7926.841463170705;8263.504189748634;8312.667493300321;8317.334613231049;8403.453775504573;6013.428724271187;6101.7559297627595;6172.598781079216;6187.041008643668;6276.497880169484;10422.166226701695;10785.946070269598;10857.67426977192;10876.78246435051;11000.889991100306;10912.454377281263;10930.781384372427;10935.83596246041;10943.890561094606;10953.123750099814;6974.857262323547;7989.440739148204;8100.2304781045705;8105.27052565272;8109;8017.19828017217;8804.735857924272;8970.596323165342;9283.907160928304;9286.30352723535;8055.637496312797;8061.637226324712;8097.676092956452;8189.385796065199;8403.621837017226;7907.2488113629115;7973;8083.6766529338165;8150.184981501802;8150.959245203973;7098.609576473137;7187.820304492429;7190.274334159869;7192.532485388433;7197.244289349753;5225.529702326809;5236.214567814706;5282.498162674539;5324.733763311741;5423.457654234545;5314.12316967696;5367.275417818544;5383.650062745909;5389;5543.9168412474655 16:42:59 INFO - PROCESS | 17254 | |4;prototype.html;319.14787517328745;320.61045829317374;329.5583917550482;332.2673504921648;336.806336356595;5055.342805435288;5066.2400639904035;5173.715445650488;5245.318108645875;5250.1599744041005;5096.95512419954;5107.4892510748905;5127.102757017526;5146.202338637517;5175.456577059411;4044.7370920890194;4049.777262250582;4057.8579749708765;4061.9845038740314;4065.451164092839;3775.5658099318516;3856.730028897978;4045.8786236412807;4091.713580049398;4118.5057793064725;3991.9600803992025;4019.4171845082446;4023.7384570003;4028.415879697442;4029.758214507124;4004.2191772604356;4013.6387725104883;4023.6781057515327;4025.3156963316305;4035.1929614077303;3555.95532568774;3557.217412169319;3565.6790888819874;3579.8031108289033;3598.6581274778855;4938.234573641092;5035.4319297158345;5041.621878359138;5061.696298222082;5069.847904562869;4569.1547063793305;4603.849037740565;4604.700694454849;4605.171069207541;4610.377599024156;5268.735503479175;5338.866528336784;5341.545968592674;5343.225232341328;5358.946410535884;3770.811459427018;3884.2037382336835;3894;3929.960700392988;3941.3299739044432;5602.327720673505;5617.887642247173;5621.297337832771;5636.323641163087;5638.689872057035;3985.6811455083525;4009.639132478091;4022.6178513041214;4028.697847661437;4033.2538480380636;3943.38877473992;4045.2314060328445;4054.6416950321973;4056.918861622751;4090.5683010946527;4615.561521655437;4616.907661846744;4622.237330840441;4627.699199552018;4635.605973492224;5332.813351532755;5376.87085711997;5444.577163162434;5444.6188766785945;5466.371367292732;1289.6453475294181;1366.8359796824245;1369.1784929042694;1389.1387339849357;1391.8468968413467;930.432436213909;932.7388331267256;949.2026697574071;954.1126752120595;958.5734348215117;5136.9743151284;5167.560757335594;5203.8178663746585;5206;5208.515573061659;5378.327709036371;5390.299261096033;5398.24424580559;5398.271233383443;5431.4840090191365;4911.608896648856;5138.614603904647;5152.433232344439;5156.736599533064;5167.896642067138;2522.7638457156227;2558.222035685181;2560.615907613873;2563.4491132864723;2566.7807791298983;4895.779689913962;4914.385701787277;4925.507449255046;4982.950170498249;5006.349174607278;4864;4888.5111488850835;4894.818368060718;5250.711210883362;5684.63049901755;5705.62913410627;5706.771729130955;5716.771329146871;5723.513501352431;5753;5535.809800892827;5539.418361072029;5542.307211598551;5580.972095139498;5591.27313449249;5396.0556902542685;5489.533389661923;5588.469095435927;5593.7693707384315;5622.610390584067;5788.450097240755;5817.476427121579;5825.883482330245;5832.912506312494;5843.824685259449;3928.7249892507252;3942.3692209246383;3947.190825880745;3948.9407658885716;3951.92096158081;5332.386775520865;5416.539594134385;5534.05920993424;5549.445055494418;5618.775248989995;5312.946870531246;5390.463717840396;5393.24944278413;5423.322084739408;5438.728063596884;5412.945870541402;5418.539424148834;5436.700981446058;5481.342238931354;5481.9036192762405;5221.284931835348;5366;5367.631254030197;5399.082156033405;5409.540189083972;5439;5449.3188351456065;5451.781928722965;5460.945390546044;5471.917921231265;5285.814996475105;5304.575633949352;5332.760025798771;5376.327959005124;5376.677399356051 16:42:59 INFO - PROCESS | 17254 | |5;yui.html;743.6690672650669;783.3772151139843;783.9137694853569;805.0218983934519;805.3825068527286;14817.407303707852;15643.687126257482;15688.843111568882;15695.764563531557;15707.136107514083;14893.851061489382;15279.77080343793;15416;15421.614459638515;15445.150516721576;665.0987911380083;792.8216151365954;813.3086876155251;817.7996390884211;820.2248874813304;818.6970820796314;819.9631016604237;821.6097353756977;821.8890449789262;822.1613953767154;826.6652005937605;827.0323721246157;827.3133299361546;828.3249151941179;828.349745449822;695.0512550368735;824.8020475085966;836.9539675317855;847.6948298612556;851.2381418630353;638.0875348251998;638.3488841381811;638.5147288061107;638.5466318913577;638.6902352359102;14902.254887255594;14951.850481495154;15035.924820375938;15067.849321506865;15071.849281507155;13160.736785264337;13205.537806176737;13624.18254904699;13690.178589284575;13741.381637826322;11115.388653624048;11537;11893.108016898766;12409.813852792215;12581.308028058453;4274.5939135782055;4290.914181716348;4323.567643235683;4331.7617531035785;4356.390105385249;75314.06910512647;75577.62211188964;76440;76590;77861.22138778596;10541.333121978278;10607.15142788575;10702.571897124028;11039.503222354853;11124.332540047622;19633.116509757096;19872;20114.497137571678;20397;20433.591328173352;7539.246075392417;7604;7610.847783044308;7651.732189373345;7684.6157692116285;4668;4668.11305851887;4673.275642275453;4762.476127625959;4804.855854324376;3234.1267857678295;3360.0927749507987;3362.5628668272966;3371.258323168899;3379.6312493440196;579.3511267380561;580.054511146828;582.8513728999078;585.853536615846;604.7006731667852;630.8485963368759;662.5556287293746;675.3111825937516;680.4658343200564;692.2074225012433;9847.704568862946;10047.949760251153;10497.265191436527;10509.369437833602;10686.73283167927;676.2426082787309;734.8052766017009;740.5926740292817;758.1925249609149;763.7222034873332;4199.790010499462;4317.201317756225;4442.466903971479;4464.397306363664;4468.642508599304;96921.51539242259;99232;100880.49559752154;117572;121641;57699.71150144222;100771.49614252028;101367;102915;102944.48527757313;70120.64939675371;82033;85023.57488212519;87088;87941;9109.726708198765;9282.164605185566;9350.719478415658;9547.952260238655;9552;49950;50010.74994625149;50855.88017677454;50878.49121508738;51500.742496288774;44005.77997109994;60437;75677;75768.62115689386;76073.23926760661;11978.72404243191;12119;12131;12246.816297755719;12302.75394492123;13771.517996870061;14027.397260273972;14084.15755596712;14636.487722929647;14971.850281497045;13104.279264640156;13145.671358216121;13192.934035329761;13731.24478153711;14183.503577374742;12900.096993210385;13147.408366623333;13258.071934964846;13328.133671311334;13727.382267797773;13125.868741312846;13207.867921320663;13366.465341386236;13517.59447216585;14033.859661403256;9377.156055954996;9455.716328510156;9501;9603.327767056238;9681.273904457054;9318.69522448987;9905.653302134391;9940.801183976424;10906.291091079054;11134.164937629548 16:42:59 INFO - PROCESS | 17254 | __end_tp_report 16:42:59 INFO - PROCESS | 17254 | __start_cc_report 16:42:59 INFO - PROCESS | 17254 | _x_x_mozilla_cycle_collect,984 16:42:59 INFO - PROCESS | 17254 | __end_cc_report 16:42:59 INFO - PROCESS | 17254 | __startTimestamp1471822979190__endTimestamp 16:42:59 INFO - PROCESS | 17254 | 16:42:59 INFO - PROCESS | 17254 | ------- Summary: start ------- 16:42:59 INFO - PROCESS | 17254 | Number of tests: 6 16:42:59 INFO - PROCESS | 17254 | 16:42:59 INFO - PROCESS | 17254 | [#0] dojo.html Cycles:165 Average:5327.06 Median:5549.45 stddev:630.89 (11.4%) stddev-sans-first:603.00 16:42:59 INFO - PROCESS | 17254 | Values: 2883.3 2932.1 2958.1 2966.8 3012.1 5189.1 5207.0 5253.8 5357.1 5396.7 5260.6 5276.3 5281.0 5286.8 5389.3 4782.6 4818.5 4932.3 4973.5 4978.4 4970.7 4983.7 5003.6 5009.0 5011.6 4749.4 4780.5 4796.5 4910.1 4928.7 4732.7 4766.3 4767.7 4770.6 4777.0 4715.2 4729.1 4804.0 4804.5 4820.0 5140.6 5288.8 5300.3 5304.7 5306.4 5654.1 5677.7 5683.9 5754.8 5761.0 5743.8 5776.9 5793.6 5800.4 5801.1 5160.9 5261.4 5398.2 5401.9 5403.6 5804.5 5911.1 5912.7 5917.5 5919.5 5650.9 5655.4 5657.9 5664.4 5664.5 5576.8 5612.7 5734.9 5748.1 5752.3 5650.2 5737.9 5741.7 5743.2 5748.5 5721.6 5749.7 5756.1 5758.8 5764.7 4264.8 4356.0 4432.8 4438.9 4439.1 3898.8 3921.5 3922.5 3931.6 3947.2 5491.5 5493.3 5493.4 5497.3 5501.1 5523.8 5549.4 5776.6 5805.7 5818.2 5372.2 5439.7 5456.6 5458.9 5477.1 5025.6 5028.9 5030.7 5036.0 5038.0 5787.6 5880.9 5934.2 5939.8 5944.3 5707.8 5780.8 5805.9 5806.4 5809.3 5986.9 5999.6 6004.1 6018.5 6023.4 5452.1 5595.6 5631.5 5709.3 5711.3 5740.3 5802.0 5836.7 5837.0 5841.2 5671.7 5685.2 5686.0 5687.9 5688.6 5441.4 5530.4 5683.5 5693.8 5695.5 5496.1 5589.2 5593.3 5596.0 5604.1 5683.0 5704.7 5705.7 5706.3 5708.1 5469.0 5500.7 5560.7 5591.3 5602.4 16:42:59 INFO - PROCESS | 17254 | 16:42:59 INFO - PROCESS | 17254 | [#1] ext.html Cycles:180 Average:63363.50 Median:238574.00 stddev:130386.42 (54.7%) stddev-sans-first:130666.94 16:42:59 INFO - PROCESS | 17254 | Values: 565.3 582.0 594.7 597.9 599.7 43468.8 44363.0 44496.0 44575.6 47985.3 45489.3 46019.5 46045.5 46051.8 46064.8 8866.4 8980.3 9025.5 9025.6 9026.3 8769.3 8874.5 8876.1 8891.0 8895.2 9021.7 9062.8 9064.8 9067.8 9072.7 8989.0 9006.6 9008.2 9012.4 9022.1 8872.8 8910.0 8925.9 8926.8 8957.7 43381.0 43661.6 43787.6 43789.8 43839.8 3521.4 3705.3 3778.6 3831.6 4025.7 32843.2 33132.8 33239.3 33381.2 33400.8 3609.7 3720.7 3751.9 3810.6 3863.7 374021.0 375626.0 375667.1 379111.0 379883.0 56893.0 57013.4 57446.4 57463.0 57531.7 59729.7 59751.7 59757.0 59785.4 59833.0 15038.4 15224.2 15235.1 15259.3 15259.3 11700.5 11768.6 11769.4 11770.4 11771.3 15149.8 15894.7 15895.0 15918.9 16123.9 6392.8 6463.4 6466.5 6572.7 6653.3 696.4 1030.7 1099.7 1104.4 1167.2 28044.3 28355.0 28957.9 29054.9 29081.0 1065.6 1090.9 1106.7 1116.9 1179.2 13926.6 14784.3 14933.7 15118.5 15134.7 619133.0 624307.0 625214.0 625944.9 627486.0 59849.0 59886.7 59923.0 59992.4 60040.0 1209.7 1360.2 1372.6 1390.9 1409.9 27591.2 29136.1 29375.6 29631.9 29659.9 50786.2 50836.2 51010.7 51119.2 51370.0 430846.0 431707.0 432695.0 432746.0 433767.0 26847.7 27412.3 27542.6 28668.9 28805.9 47343.0 47813.0 47914.8 48030.3 48367.8 40311.0 40729.2 41498.8 43019.6 44515.6 41877.8 42788.1 45885.5 46141.3 46208.8 37880.2 38560.6 39030.0 39313.6 39437.8 42571.4 45169.3 45390.3 46228.0 47003.8 26677.2 26860.7 26977.7 27058.7 27136.2 16:42:59 INFO - PROCESS | 17254 | 16:42:59 INFO - PROCESS | 17254 | [#2] jquery.html Cycles:180 Average:28972.90 Median:375.97 stddev:81848.27 (21769.8%) stddev-sans-first:82049.68 16:42:59 INFO - PROCESS | 17254 | Values: 359.2 370.8 381.1 390.2 407.8 15427.3 17530.4 19159.1 19954.9 20284.4 19144.0 19417.1 19417.3 20168.2 20210.2 5184.3 5565.7 5654.8 5786.7 5793.9 5599.0 5677.2 5706.4 5708.1 5709.5 5505.4 5666.1 5672.5 5678.9 5772.8 5910.4 5913.7 5921.4 5922.6 5924.6 5531.6 5694.4 5728.1 5736.5 5739.0 13830.6 14190.6 14195.3 22041.3 23822.3 2222.2 2304.8 2448.2 2475.6 2875.7 10085.9 10678.0 10728.2 12634.9 14384.4 1858.4 1953.9 1971.3 2053.4 2053.4 82671.6 83943.0 84383.6 86294.6 87836.6 10983.8 11065.9 11114.7 11177.4 11287.5 15338.9 15352.4 15362.2 15364.8 15384.8 7612.7 8009.8 8022.5 8238.8 8242.0 7335.6 7419.8 7519.3 7550.1 7829.5 4535.6 4615.2 4659.6 4809.1 4831.0 1916.2 1936.7 1965.5 1966.0 1988.6 852.0 926.0 980.4 984.9 1055.6 17016.5 17044.7 18077.1 18147.2 18626.1 969.8 989.2 1012.5 1018.8 1024.1 9111.3 9749.2 10092.1 10141.3 10179.6 481116.0 492030.0 494939.0 501043.0 508674.0 89279.0 92409.0 92445.0 94307.5 94354.0 981.7 998.9 1020.8 1023.3 1023.5 15537.3 16132.4 16157.4 16188.8 16375.7 39570.0 41208.2 43190.8 43676.8 44254.8 58007.4 58046.4 59111.0 59264.0 59577.0 7988.5 8272.3 8424.4 8492.9 8764.8 10268.6 12781.1 12815.2 13085.9 13118.4 10661.4 10689.3 10760.2 11167.3 11175.4 11086.1 11198.5 11209.8 11272.5 11761.2 10671.1 10793.8 10928.8 11156.6 11350.8 8073.6 8204.9 8303.3 8338.6 8490.5 8078.6 10597.3 10631.2 10757.8 11111.1 16:42:59 INFO - PROCESS | 17254 | 16:42:59 INFO - PROCESS | 17254 | [#3] mootools.html Cycles:180 Average:6039.59 Median:4800.65 stddev:3500.34 (72.9%) stddev-sans-first:3491.93 16:42:59 INFO - PROCESS | 17254 | Values: 1286.6 1471.1 1513.3 1608.4 1755.5 8303.8 8607.1 8707.6 9005.9 9015.4 9190.6 9318.9 9330.7 9333.8 9346.9 2144.2 2436.3 2480.8 2502.5 2505.2 2488.4 2515.2 2522.7 2524.8 2531.5 2431.0 2448.7 2451.0 2487.5 2496.4 2390.8 2434.9 2441.8 2444.5 2478.4 2454.3 2464.2 2475.4 2476.3 2479.5 9454.7 9537.8 9596.6 9645.8 9655.8 5467.3 5602.5 5620.4 5620.9 5628.0 3509.9 3594.4 3622.3 3692.4 3702.9 1180.5 1187.8 1195.3 1212.7 1225.2 12702.0 12769.0 12815.1 12843.2 12855.4 4463.9 4641.6 4753.2 4848.1 4867.9 10067.6 10128.9 10266.4 10302.9 10303.1 5349.3 5349.5 5352.9 5360.0 5367.8 4407.1 4921.3 4935.5 4968.4 5158.0 3911.6 3939.0 4035.7 4035.7 4159.1 1064.1 1070.3 1074.3 1083.8 1115.0 844.8 856.8 885.4 941.9 962.6 5812.9 5818.9 5837.5 5854.7 6157.1 935.2 939.5 964.3 1008.9 1038.3 3901.6 4026.9 4043.5 4063.9 4095.3 11486.2 11989.5 11990.0 12015.7 12018.0 11878.6 11879.6 11885.5 11891.3 11894.2 7926.8 8263.5 8312.7 8317.3 8403.5 6013.4 6101.8 6172.6 6187.0 6276.5 10422.2 10785.9 10857.7 10876.8 11000.9 10912.5 10930.8 10935.8 10943.9 10953.1 6974.9 7989.4 8100.2 8105.3 8109.0 8017.2 8804.7 8970.6 9283.9 9286.3 8055.6 8061.6 8097.7 8189.4 8403.6 7907.2 7973.0 8083.7 8150.2 8151.0 7098.6 7187.8 7190.3 7192.5 7197.2 5225.5 5236.2 5282.5 5324.7 5423.5 5314.1 5367.3 5383.7 5389.0 5543.9 16:42:59 INFO - PROCESS | 17254 | 16:42:59 INFO - PROCESS | 17254 | [#4] prototype.html Cycles:180 Average:4513.39 Median:5142.41 stddev:1330.50 (25.9%) stddev-sans-first:1296.46 16:42:59 INFO - PROCESS | 17254 | Values: 319.1 320.6 329.6 332.3 336.8 5055.3 5066.2 5173.7 5245.3 5250.2 5097.0 5107.5 5127.1 5146.2 5175.5 4044.7 4049.8 4057.9 4062.0 4065.5 3775.6 3856.7 4045.9 4091.7 4118.5 3992.0 4019.4 4023.7 4028.4 4029.8 4004.2 4013.6 4023.7 4025.3 4035.2 3556.0 3557.2 3565.7 3579.8 3598.7 4938.2 5035.4 5041.6 5061.7 5069.8 4569.2 4603.8 4604.7 4605.2 4610.4 5268.7 5338.9 5341.5 5343.2 5358.9 3770.8 3884.2 3894.0 3930.0 3941.3 5602.3 5617.9 5621.3 5636.3 5638.7 3985.7 4009.6 4022.6 4028.7 4033.3 3943.4 4045.2 4054.6 4056.9 4090.6 4615.6 4616.9 4622.2 4627.7 4635.6 5332.8 5376.9 5444.6 5444.6 5466.4 1289.6 1366.8 1369.2 1389.1 1391.8 930.4 932.7 949.2 954.1 958.6 5137.0 5167.6 5203.8 5206.0 5208.5 5378.3 5390.3 5398.2 5398.3 5431.5 4911.6 5138.6 5152.4 5156.7 5167.9 2522.8 2558.2 2560.6 2563.4 2566.8 4895.8 4914.4 4925.5 4983.0 5006.3 4864.0 4888.5 4894.8 5250.7 5684.6 5705.6 5706.8 5716.8 5723.5 5753.0 5535.8 5539.4 5542.3 5581.0 5591.3 5396.1 5489.5 5588.5 5593.8 5622.6 5788.5 5817.5 5825.9 5832.9 5843.8 3928.7 3942.4 3947.2 3948.9 3951.9 5332.4 5416.5 5534.1 5549.4 5618.8 5312.9 5390.5 5393.2 5423.3 5438.7 5412.9 5418.5 5436.7 5481.3 5481.9 5221.3 5366.0 5367.6 5399.1 5409.5 5439.0 5449.3 5451.8 5460.9 5471.9 5285.8 5304.6 5332.8 5376.3 5376.7 16:42:59 INFO - PROCESS | 17254 | 16:42:59 INFO - PROCESS | 17254 | [#5] yui.html Cycles:180 Average:19873.13 Median:4670.69 stddev:28531.42 (610.9%) stddev-sans-first:28575.31 16:42:59 INFO - PROCESS | 17254 | Values: 743.7 783.4 783.9 805.0 805.4 14817.4 15643.7 15688.8 15695.8 15707.1 14893.9 15279.8 15416.0 15421.6 15445.2 665.1 792.8 813.3 817.8 820.2 818.7 820.0 821.6 821.9 822.2 826.7 827.0 827.3 828.3 828.3 695.1 824.8 837.0 847.7 851.2 638.1 638.3 638.5 638.5 638.7 14902.3 14951.9 15035.9 15067.8 15071.8 13160.7 13205.5 13624.2 13690.2 13741.4 11115.4 11537.0 11893.1 12409.8 12581.3 4274.6 4290.9 4323.6 4331.8 4356.4 75314.1 75577.6 76440.0 76590.0 77861.2 10541.3 10607.2 10702.6 11039.5 11124.3 19633.1 19872.0 20114.5 20397.0 20433.6 7539.2 7604.0 7610.8 7651.7 7684.6 4668.0 4668.1 4673.3 4762.5 4804.9 3234.1 3360.1 3362.6 3371.3 3379.6 579.4 580.1 582.9 585.9 604.7 630.8 662.6 675.3 680.5 692.2 9847.7 10047.9 10497.3 10509.4 10686.7 676.2 734.8 740.6 758.2 763.7 4199.8 4317.2 4442.5 4464.4 4468.6 96921.5 99232.0 100880.5 117572.0 121641.0 57699.7 100771.5 101367.0 102915.0 102944.5 70120.6 82033.0 85023.6 87088.0 87941.0 9109.7 9282.2 9350.7 9548.0 9552.0 49950.0 50010.7 50855.9 50878.5 51500.7 44005.8 60437.0 75677.0 75768.6 76073.2 11978.7 12119.0 12131.0 12246.8 12302.8 13771.5 14027.4 14084.2 14636.5 14971.9 13104.3 13145.7 13192.9 13731.2 14183.5 12900.1 13147.4 13258.1 13328.1 13727.4 13125.9 13207.9 13366.5 13517.6 14033.9 9377.2 9455.7 9501.0 9603.3 9681.3 9318.7 9905.7 9940.8 10906.3 11134.2 16:42:59 INFO - PROCESS | 17254 | -------- Summary: end -------- 16:42:59 INFO - PROCESS | 17254 | 16:43:00 INFO - TEST-INFO | 17254: exit 0 16:43:00 INFO - TEST-OK | dromaeo_css | took 1116438ms 16:43:00 INFO - TEST-START | kraken 16:43:00 INFO - operating with platform_type : linux_ 16:43:00 INFO - Initialising browser for kraken test... 16:43:00 INFO - TEST-INFO | started process 17560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5DVYXt/profile http://localhost:53402/getInfo.html) 16:43:04 INFO - PROCESS | 17560 | __metrics Screen width/height:1600/1200 16:43:04 INFO - PROCESS | 17560 | colorDepth:24 16:43:04 INFO - PROCESS | 17560 | Browser inner width/height: 1024/697 16:43:04 INFO - PROCESS | 17560 | __metrics 16:43:05 INFO - PROCESS | 17560 | 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" 16:43:05 INFO - PROCESS | 17560 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:43:05 INFO - PROCESS | 17560 | console.error: PushService: 16:43:05 INFO - PROCESS | 17560 | stateChangeProcessEnqueue: Error transitioning state 16:43:05 INFO - PROCESS | 17560 | UnknownError 16:43:06 INFO - TEST-INFO | 17560: exit 0 16:43:06 INFO - Browser initialized. 16:43:06 INFO - Running cycle 1/1 for kraken test... 16:43:06 INFO - TEST-INFO | started process 17644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5DVYXt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:18 INFO - PROCESS | 17644 | RSS: Main: 173477888 16:43:18 INFO - PROCESS | 17644 | 16:43:20 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53402/tests/kraken/driver.html?testName=audio-beat-detection) 16:43:21 INFO - PROCESS | 17644 | RSS: Main: 233811968 16:43:21 INFO - PROCESS | 17644 | 16:43:24 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53402/tests/kraken/driver.html?testName=audio-dft) 16:43:25 INFO - PROCESS | 17644 | RSS: Main: 225525760 16:43:25 INFO - PROCESS | 17644 | 16:43:28 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53402/tests/kraken/driver.html?testName=audio-fft) 16:43:28 INFO - PROCESS | 17644 | RSS: Main: 301486080 16:43:28 INFO - PROCESS | 17644 | 16:43:30 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53402/tests/kraken/driver.html?testName=audio-oscillator) 16:43:31 INFO - PROCESS | 17644 | RSS: Main: 209461248 16:43:31 INFO - PROCESS | 17644 | 16:43:33 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53402/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:43:34 INFO - PROCESS | 17644 | RSS: Main: 213078016 16:43:34 INFO - PROCESS | 17644 | 16:43:37 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53402/tests/kraken/driver.html?testName=imaging-darkroom) 16:43:38 INFO - PROCESS | 17644 | RSS: Main: 250339328 16:43:38 INFO - PROCESS | 17644 | 16:43:41 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53402/tests/kraken/driver.html?testName=imaging-desaturate) 16:43:42 INFO - PROCESS | 17644 | RSS: Main: 248266752 16:43:42 INFO - PROCESS | 17644 | 16:43:44 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53402/tests/kraken/driver.html?testName=json-parse-financial) 16:43:45 INFO - PROCESS | 17644 | RSS: Main: 248442880 16:43:45 INFO - PROCESS | 17644 | 16:43:47 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53402/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:43:47 INFO - PROCESS | 17644 | RSS: Main: 211165184 16:43:47 INFO - PROCESS | 17644 | 16:43:49 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53402/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:43:50 INFO - PROCESS | 17644 | RSS: Main: 218841088 16:43:50 INFO - PROCESS | 17644 | 16:43:52 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53402/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:43:52 INFO - PROCESS | 17644 | RSS: Main: 223297536 16:43:52 INFO - PROCESS | 17644 | 16:43:55 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:43:56 INFO - PROCESS | 17644 | RSS: Main: 218116096 16:43:56 INFO - PROCESS | 17644 | 16:43:59 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:43:59 INFO - PROCESS | 17644 | RSS: Main: 221360128 16:43:59 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | Cycle 1(1): loaded http://localhost:53402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53402/tests/kraken/driver.html?testName=ai-astar) 16:44:01 INFO - PROCESS | 17644 | RSS: Main: 272760832 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | __start_tp_report 16:44:01 INFO - PROCESS | 17644 | _x_x_mozilla_page_load 16:44:01 INFO - PROCESS | 17644 | _x_x_mozilla_page_load_details 16:44:01 INFO - PROCESS | 17644 | |i|pagename|runs| 16:44:01 INFO - PROCESS | 17644 | |0;ai-astar;96;111;107;111;110;110;116;110;109;110 16:44:01 INFO - PROCESS | 17644 | |1;audio-beat-detection;148;118;155;180;121;141;147;121;178;116 16:44:01 INFO - PROCESS | 17644 | |2;audio-dft;161;161;163;161;161;161;160;160;162;162 16:44:01 INFO - PROCESS | 17644 | |3;audio-fft;75;77;75;168;78;76;76;75;180;76 16:44:01 INFO - PROCESS | 17644 | |4;audio-oscillator;84;84;154;84;84;86;151;85;84;141 16:44:01 INFO - PROCESS | 17644 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;117;117;117 16:44:01 INFO - PROCESS | 17644 | |6;imaging-darkroom;146;146;146;146;146;147;146;146;146;146 16:44:01 INFO - PROCESS | 17644 | |7;imaging-desaturate;96;96;95;95;96;95;96;95;96;96 16:44:01 INFO - PROCESS | 17644 | |8;json-parse-financial;50;51;51;51;53;51;52;53;52;52 16:44:01 INFO - PROCESS | 17644 | |9;json-stringify-tinderbox;61;61;60;61;61;62;61;61;61;61 16:44:01 INFO - PROCESS | 17644 | |10;stanford-crypto-aes;79;78;85;78;81;86;81;79;86;80 16:44:01 INFO - PROCESS | 17644 | |11;stanford-crypto-ccm;124;125;126;136;146;127;147;129;151;130 16:44:01 INFO - PROCESS | 17644 | |12;stanford-crypto-pbkdf2;167;164;167;165;166;171;168;164;167;165 16:44:01 INFO - PROCESS | 17644 | |13;stanford-crypto-sha256-iterative;67;65;67;65;67;66;65;64;64;67 16:44:01 INFO - PROCESS | 17644 | __end_tp_report 16:44:01 INFO - PROCESS | 17644 | __start_cc_report 16:44:01 INFO - PROCESS | 17644 | _x_x_mozilla_cycle_collect,1708 16:44:01 INFO - PROCESS | 17644 | __end_cc_report 16:44:01 INFO - PROCESS | 17644 | __startTimestamp1471823041682__endTimestamp 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | ------- Summary: start ------- 16:44:01 INFO - PROCESS | 17644 | Number of tests: 14 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:5.10 (4.6%) stddev-sans-first:2.40 16:44:01 INFO - PROCESS | 17644 | Values: 96.0 111.0 107.0 111.0 110.0 110.0 116.0 110.0 109.0 110.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:147.50 stddev:23.81 (16.1%) stddev-sans-first:25.17 16:44:01 INFO - PROCESS | 17644 | Values: 148.0 118.0 155.0 180.0 121.0 141.0 147.0 121.0 178.0 116.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 16:44:01 INFO - PROCESS | 17644 | Values: 161.0 161.0 163.0 161.0 161.0 161.0 160.0 160.0 162.0 162.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:41.43 (54.5%) stddev-sans-first:43.27 16:44:01 INFO - PROCESS | 17644 | Values: 75.0 77.0 75.0 168.0 78.0 76.0 76.0 75.0 180.0 76.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:84.00 stddev:31.20 (37.1%) stddev-sans-first:32.27 16:44:01 INFO - PROCESS | 17644 | Values: 84.0 84.0 154.0 84.0 84.0 86.0 151.0 85.0 84.0 141.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 16:44:01 INFO - PROCESS | 17644 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 16:44:01 INFO - PROCESS | 17644 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:44:01 INFO - PROCESS | 17644 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:0.83 16:44:01 INFO - PROCESS | 17644 | Values: 50.0 51.0 51.0 51.0 53.0 51.0 52.0 53.0 52.0 52.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 16:44:01 INFO - PROCESS | 17644 | Values: 61.0 61.0 60.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:3.20 (3.9%) stddev-sans-first:3.28 16:44:01 INFO - PROCESS | 17644 | Values: 79.0 78.0 85.0 78.0 81.0 86.0 81.0 79.0 86.0 80.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:133.00 stddev:10.22 (7.7%) stddev-sans-first:10.17 16:44:01 INFO - PROCESS | 17644 | Values: 124.0 125.0 126.0 136.0 146.0 127.0 147.0 129.0 151.0 130.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:167.00 stddev:2.12 (1.3%) stddev-sans-first:2.24 16:44:01 INFO - PROCESS | 17644 | Values: 167.0 164.0 167.0 165.0 166.0 171.0 168.0 164.0 167.0 165.0 16:44:01 INFO - PROCESS | 17644 | 16:44:01 INFO - PROCESS | 17644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.24 16:44:01 INFO - PROCESS | 17644 | Values: 67.0 65.0 67.0 65.0 67.0 66.0 65.0 64.0 64.0 67.0 16:44:01 INFO - PROCESS | 17644 | -------- Summary: end -------- 16:44:01 INFO - PROCESS | 17644 | 16:44:02 INFO - TEST-INFO | 17644: exit 0 16:44:02 INFO - TEST-OK | kraken | took 62816ms 16:44:02 INFO - SUITE-END | took 1179s 16:44:03 INFO - Completed test suite (00:19:39) 16:44:03 INFO - javascript benchmark 16:44:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2883.336832528517, 2932.1057077591327, 2958.1273524310327, 2966.777491688123, 3012.1114271289975, 5189.117849965505, 5207.0, 5253.763580638871, 5357.08929481988, 5396.703181325026, 5260.579153667707, 5276.261323414725, 5280.973595132019, 5286.814961476349, 5389.272448219489, 4782.569568738812, 4818.469968303492, 4932.309476673268, 4973.452920178777, 4978.427480839696, 4970.701757894538, 4983.676061056038, 5003.624728145385, 5009.0, 5011.624128190382, 4749.382580264543, 4780.545848144421, 4796.544328288807, 4910.091633047879, 4928.728919909404, 4732.692374995614, 4766.332713420124, 4767.713937163781, 4770.594499467549, 4777.0445910817625, 4715.221988371914, 4729.101470720552, 4804.015176888729, 4804.495527969582, 4819.987802561466, 5140.640155189139, 5288.788448462057, 5300.257963885059, 5304.655197412195, 5306.442823503554, 5654.067078931971, 5677.687727175004, 5683.857903552403, 5754.827355179351, 5761.0, 5743.798967036176, 5776.913346299809, 5793.594448388572, 5800.4489573490455, 5801.100829371412, 5160.948390516121, 5261.447548007481, 5398.163284690879, 5401.891962160774, 5403.648762830403, 5804.506616937523, 5911.113333000085, 5912.733926973297, 5917.467427931507, 5919.526437884959, 5650.915236271459, 5655.406182350876, 5657.858553536194, 5664.376918538957, 5664.49019588239, 5576.832695019156, 5612.719364031782, 5734.942650573525, 5748.080307150919, 5752.3097228332035, 5650.180723795109, 5737.942620573825, 5741.712914354349, 5743.2246646703, 5748.511376532958, 5721.599488035881, 5749.683767392834, 5756.0502517084215, 5758.798442054508, 5764.682942438206, 4264.829406823755, 4355.956440435555, 4432.800523976429, 4438.911221775546, 4439.067795762926, 3898.7855667938534, 3921.529416469985, 3922.4508568800393, 3931.64615184629, 3947.17109407022, 5491.478309560585, 5493.285872836505, 5493.423190564933, 5497.340319161646, 5501.092319767194, 5523.7790488380815, 5549.445055494499, 5776.595638305278, 5805.7387417566315, 5818.156367326714, 5372.221027951004, 5439.728013599304, 5456.590755693339, 5458.9454105458435, 5477.123660214426, 5025.623078269145, 5028.949710502849, 5030.748462576857, 5036.043151801219, 5037.974810125999, 5787.565932555075, 5880.852978675567, 5934.19888315072, 5939.792107276225, 5944.346121926585, 5707.7716891325545, 5780.826575202751, 5805.883882322414, 5806.361300257053, 5809.331926828299, 5986.910196346971, 5999.5800293979, 6004.0693692477735, 6018.518518518596, 6023.427774361428, 5452.100403433389, 5595.63628364155, 5631.549476041989, 5709.314882214161, 5711.343195532567, 5740.253767010262, 5802.0, 5836.678982655825, 5836.970815145897, 5841.211436456024, 5671.744771485211, 5685.232493613309, 5685.971570142123, 5687.9431205687415, 5688.63023903445, 5441.428649991693, 5530.391656917655, 5683.545316374597, 5693.772249110155, 5695.45893140151, 5496.148097044965, 5589.161625756169, 5593.300837395325, 5596.0, 5604.075327570905, 5683.0, 5704.714764261687, 5705.686187259741, 5706.258186435737, 5708.058170401837, 5469.0, 5500.669959802424, 5560.666360018412, 5591.329040515164, 5602.355729091207], "value": 5281.823597824613, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.3244372974295, 581.9648240965928, 594.7124475510518, 597.8983572792624, 599.7121381736769, 43468.782656086754, 44363.0, 44496.0, 44575.55424445755, 47985.28022079663, 45489.31766023504, 46019.53980460195, 46045.539544604544, 46051.76974115133, 46064.769676151656, 8866.379353445262, 8980.32647551433, 9025.458472491639, 9025.638974441015, 9026.323025773061, 8769.298456123526, 8874.511901845395, 8876.068012858654, 8891.0, 8895.199432051115, 9021.729348119534, 9062.773430664252, 9064.773380665503, 9067.773305667379, 9072.682456114037, 8989.0, 9006.59470323837, 9008.234300084436, 9012.41419307743, 9022.14289642483, 8872.778180545474, 8909.955450222773, 8925.866112008325, 8926.821463570692, 8957.731268061969, 43381.0, 43661.56338436607, 43787.56212437899, 43789.78105109454, 43839.78080109611, 3521.366154092262, 3705.2589482103685, 3778.6410291022307, 3831.616838316174, 4025.7383270087353, 32843.17892052694, 33132.83433582841, 33239.3352132956, 33381.16547086318, 33400.83299583511, 3609.657082577151, 3720.7303544837628, 3751.9437208441896, 3810.5617853946874, 3863.729538932276, 374021.0, 375626.0, 375667.12166439265, 379111.0, 379883.0, 56893.0, 57013.42986570081, 57446.425535744944, 57463.0, 57531.712341438026, 59729.701351492964, 59751.701241493516, 59757.0, 59785.40214597886, 59833.0, 15038.398464061534, 15224.238788060775, 15235.085894846345, 15259.313330900137, 15259.313330900137, 11700.531978720755, 11768.58809941648, 11769.411529423494, 11770.352630605228, 11771.293722376513, 15149.848501514844, 15894.682106357808, 15895.0, 15918.9204053979, 16123.919380403024, 6392.808215753535, 6463.353664633593, 6466.450351720063, 6572.737090516326, 6653.334666533405, 696.4101387773827, 1030.7320096774893, 1099.7305660113323, 1104.3981030338484, 1167.1538134852333, 28044.29889252744, 28355.0, 28957.85521072381, 29054.854725726236, 29081.0, 1065.621704294964, 1090.8909607618225, 1106.7011906785124, 1116.9218154729092, 1179.2452830188686, 13926.58220253394, 14784.279475982532, 14933.687399857356, 15118.546443606709, 15134.697306054037, 619133.0, 624307.0, 625214.0, 625944.8702756457, 627486.0, 59849.0, 59886.70056649689, 59923.0, 59992.400075999554, 60040.0, 1209.673388185185, 1360.156702844243, 1372.629390064697, 1390.874821266091, 1409.8872090232758, 27591.172264832087, 29136.125916222547, 29375.559366609945, 29631.85184074066, 29659.851700741357, 50786.23820642619, 50836.237456438925, 51010.74494627503, 51119.233211501116, 51370.0, 430846.0, 431707.0, 432695.0, 432746.0, 433767.0, 26847.731522684524, 27412.314692132855, 27542.5868611975, 28668.856655716587, 28805.85597072001, 47343.00482908236, 47813.0, 47914.760426197645, 48030.279545806145, 48367.758161210375, 40311.0, 40729.1854162921, 41498.79250603849, 43019.56980430281, 44515.554844451144, 41877.79061104675, 42788.14423711446, 45885.541144589464, 46141.30788038115, 46208.768956156346, 37880.24239515139, 38560.6143938557, 39030.0, 39313.606863930996, 39437.80281098576, 42571.3614295792, 45169.32246016247, 45390.31914521351, 46228.0, 47003.76498117488, 26677.199684009513, 26860.731392685822, 26977.730222697523, 27058.72941270641, 27136.18591442181], "value": 19955.500205542037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.20436233742254, 370.80903334782573, 381.1329226010826, 390.1514206600643, 407.8103681787968, 15427.305771240293, 17530.38643647471, 19159.137838797255, 19954.900225498888, 20284.391468255977, 19144.0, 19417.126229319678, 19417.32039378622, 20168.19327226909, 20210.191592336327, 5184.326037615124, 5565.6660600364, 5654.846054256777, 5786.71066446676, 5793.855153621172, 5599.048161812481, 5677.205191273225, 5706.429357064302, 5708.058170401879, 5709.486146246837, 5505.394406615269, 5666.093425051992, 5672.461116193955, 5678.858028549278, 5772.769089236425, 5910.379410161957, 5913.704314784265, 5921.378255283198, 5922.615030023035, 5924.585279030491, 5531.557475401958, 5694.402087780806, 5728.112142617901, 5736.483716465538, 5739.0, 13830.585082447542, 14190.645233869132, 14195.290235488184, 22041.338759837232, 23822.285331440085, 2222.244436891465, 2304.8271379646426, 2448.192096608133, 2475.554400207962, 2875.683674795771, 10085.949570252102, 10678.0, 10728.249022568423, 12634.936825315815, 14384.424623015067, 1858.4145994011842, 1953.8925359105244, 1971.2509246486386, 2053.363457328218, 2053.3839848045677, 82671.586642067, 83943.0, 84383.57808210982, 86294.56852715697, 87836.56081719615, 10983.835242471368, 11065.889341106486, 11114.722131946766, 11177.44112794357, 11287.49206285719, 15338.923305383401, 15352.385904563916, 15362.231888405759, 15364.846351536342, 15384.846151538566, 7612.657430415645, 8009.838573406823, 8022.518648881086, 8238.8352232955, 8241.95879020601, 7335.596542190124, 7419.777406677808, 7519.323260906544, 7550.093988721389, 7829.530228186327, 4535.569120933506, 4615.215413379734, 4659.603933665609, 4809.062232864558, 4831.0, 1916.1951980168362, 1936.7191757195128, 1965.518447980254, 1966.0, 1988.6122206169657, 851.9957400213083, 925.9629614815332, 980.4460479829016, 984.886738025122, 1055.5883205549842, 17016.48950531486, 17044.659106818042, 18077.09614519269, 18147.18337674808, 18626.06869656512, 969.8157350103598, 989.1839232632963, 1012.5342342522375, 1018.7911478146962, 1024.1192574386023, 9111.27109831212, 9749.171320437701, 10092.142167915663, 10141.29010969225, 10179.592816287413, 481116.0, 492030.0, 494939.0, 501043.0, 508674.0, 89279.0, 92409.0, 92445.0, 94307.52846235725, 94354.0, 981.6907674082784, 998.9111868063845, 1020.8009438159488, 1023.2785885950387, 1023.5291765787821, 15537.300821463288, 16132.435364762177, 16157.353705851634, 16188.838111619205, 16375.67248655044, 39570.0, 41208.1758364837, 43190.78404608082, 43676.78161609299, 44254.77872610616, 58007.419925800205, 58046.41953580579, 59111.0, 59264.0, 59577.0, 7988.480748751313, 8272.296854767412, 8424.368172387218, 8492.915070849212, 8764.76629439808, 10268.58925642966, 12781.105322627327, 12815.16701414405, 13085.934570327088, 13118.409671564994, 10661.360318380923, 10689.30519516229, 10760.246782725135, 11167.25417161798, 11175.441227938732, 11086.113110951266, 11198.496067677137, 11209.831852522382, 11272.549098035986, 11761.176717629683, 10671.092957098734, 10793.838092428463, 10928.836067459153, 11156.609518667132, 11350.829737553779, 8073.636686349011, 8204.876926845982, 8303.294219991127, 8338.624761885609, 8490.490570565786, 8078.609131303567, 10597.25819192649, 10631.202659800701, 10757.784844303227, 11111.111111111253], "value": 9031.429466576572, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.6140157952611, 1471.0511719940635, 1513.2585033333667, 1608.3807734022398, 1755.4996825904611, 8303.750887473378, 8607.09625489324, 8707.564621768903, 9005.864912026309, 9015.36892417531, 9190.632374705005, 9318.906810931889, 9330.673426430076, 9333.81332373352, 9346.859797103049, 2144.2280778919576, 2436.3421876093444, 2480.7643273889, 2502.461970676304, 2505.210858579551, 2488.4027833320056, 2515.157422263544, 2522.697276326843, 2524.835885667435, 2531.50635626053, 2430.987845060772, 2448.7183973843057, 2451.0318424222423, 2487.502499500098, 2496.400863792686, 2390.8206884483734, 2434.85390876548, 2441.829071964963, 2444.486657801855, 2478.392793765539, 2454.2882564056404, 2464.236086813076, 2475.405902583367, 2476.3313905245664, 2479.5164942836154, 9454.669086581936, 9537.761555961088, 9596.568154433067, 9645.807083858284, 9655.758606034835, 5467.343918729738, 5602.523785478239, 5620.353659329188, 5620.887582248373, 5628.0, 3509.94735078974, 3594.388953877847, 3622.3479773640734, 3692.40921452569, 3702.9444558331647, 1180.4510902430325, 1187.7921363761393, 1195.2888031621171, 1212.6968257935516, 1225.197495640357, 12702.0, 12769.0423218259, 12815.102942794101, 12843.229406235656, 12855.421506032157, 4463.866084017484, 4641.605463535638, 4753.215719406259, 4848.0788650156355, 4867.9269810952865, 10067.597296108073, 10128.898711012944, 10266.384016959006, 10302.948485257675, 10303.072723454925, 5349.251104845324, 5349.465053494697, 5352.892942141213, 5360.0, 5367.785288588413, 4407.140607581555, 4921.26181072842, 4935.506449355035, 4968.403791545038, 5158.019976204584, 3911.6283953024417, 3939.0, 4035.6569691576547, 4035.6771458283265, 4159.1265834175165, 1064.0580939784923, 1070.29895418501, 1074.312440038376, 1083.7940791249637, 1114.9797934889484, 844.7761343244046, 856.8414843254018, 885.4465958775766, 941.8963913969458, 962.5620342744174, 5812.912806307909, 5818.941810581925, 5837.47462728348, 5854.736536855852, 6157.138000679908, 935.209747763139, 939.478589382899, 964.2816102004052, 1008.8839783425, 1038.3406536849004, 3901.6098390160755, 4026.8791936241373, 4043.5147782266317, 4063.9390409143884, 4095.3037983542868, 11486.19596628228, 11989.460474278678, 11990.0, 12015.699607509881, 12018.0, 11878.643640690792, 11879.643610691694, 11885.465154068088, 11891.345975971231, 11894.226875253082, 7926.841463170705, 8263.504189748634, 8312.667493300321, 8317.334613231049, 8403.453775504573, 6013.428724271187, 6101.7559297627595, 6172.598781079216, 6187.041008643668, 6276.497880169484, 10422.166226701695, 10785.946070269598, 10857.67426977192, 10876.78246435051, 11000.889991100306, 10912.454377281263, 10930.781384372427, 10935.83596246041, 10943.890561094606, 10953.123750099814, 6974.857262323547, 7989.440739148204, 8100.2304781045705, 8105.27052565272, 8109.0, 8017.19828017217, 8804.735857924272, 8970.596323165342, 9283.907160928304, 9286.30352723535, 8055.637496312797, 8061.637226324712, 8097.676092956452, 8189.385796065199, 8403.621837017226, 7907.2488113629115, 7973.0, 8083.6766529338165, 8150.184981501802, 8150.959245203973, 7098.609576473137, 7187.820304492429, 7190.274334159869, 7192.532485388433, 7197.244289349753, 5225.529702326809, 5236.214567814706, 5282.498162674539, 5324.733763311741, 5423.457654234545, 5314.12316967696, 5367.275417818544, 5383.650062745909, 5389.0, 5543.9168412474655], "value": 4786.500098498537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.14787517328745, 320.61045829317374, 329.5583917550482, 332.2673504921648, 336.806336356595, 5055.342805435288, 5066.2400639904035, 5173.715445650488, 5245.318108645875, 5250.1599744041005, 5096.95512419954, 5107.4892510748905, 5127.102757017526, 5146.202338637517, 5175.456577059411, 4044.7370920890194, 4049.777262250582, 4057.8579749708765, 4061.9845038740314, 4065.451164092839, 3775.5658099318516, 3856.730028897978, 4045.8786236412807, 4091.713580049398, 4118.5057793064725, 3991.9600803992025, 4019.4171845082446, 4023.7384570003, 4028.415879697442, 4029.758214507124, 4004.2191772604356, 4013.6387725104883, 4023.6781057515327, 4025.3156963316305, 4035.1929614077303, 3555.95532568774, 3557.217412169319, 3565.6790888819874, 3579.8031108289033, 3598.6581274778855, 4938.234573641092, 5035.4319297158345, 5041.621878359138, 5061.696298222082, 5069.847904562869, 4569.1547063793305, 4603.849037740565, 4604.700694454849, 4605.171069207541, 4610.377599024156, 5268.735503479175, 5338.866528336784, 5341.545968592674, 5343.225232341328, 5358.946410535884, 3770.811459427018, 3884.2037382336835, 3894.0, 3929.960700392988, 3941.3299739044432, 5602.327720673505, 5617.887642247173, 5621.297337832771, 5636.323641163087, 5638.689872057035, 3985.6811455083525, 4009.639132478091, 4022.6178513041214, 4028.697847661437, 4033.2538480380636, 3943.38877473992, 4045.2314060328445, 4054.6416950321973, 4056.918861622751, 4090.5683010946527, 4615.561521655437, 4616.907661846744, 4622.237330840441, 4627.699199552018, 4635.605973492224, 5332.813351532755, 5376.87085711997, 5444.577163162434, 5444.6188766785945, 5466.371367292732, 1289.6453475294181, 1366.8359796824245, 1369.1784929042694, 1389.1387339849357, 1391.8468968413467, 930.432436213909, 932.7388331267256, 949.2026697574071, 954.1126752120595, 958.5734348215117, 5136.9743151284, 5167.560757335594, 5203.8178663746585, 5206.0, 5208.515573061659, 5378.327709036371, 5390.299261096033, 5398.24424580559, 5398.271233383443, 5431.4840090191365, 4911.608896648856, 5138.614603904647, 5152.433232344439, 5156.736599533064, 5167.896642067138, 2522.7638457156227, 2558.222035685181, 2560.615907613873, 2563.4491132864723, 2566.7807791298983, 4895.779689913962, 4914.385701787277, 4925.507449255046, 4982.950170498249, 5006.349174607278, 4864.0, 4888.5111488850835, 4894.818368060718, 5250.711210883362, 5684.63049901755, 5705.62913410627, 5706.771729130955, 5716.771329146871, 5723.513501352431, 5753.0, 5535.809800892827, 5539.418361072029, 5542.307211598551, 5580.972095139498, 5591.27313449249, 5396.0556902542685, 5489.533389661923, 5588.469095435927, 5593.7693707384315, 5622.610390584067, 5788.450097240755, 5817.476427121579, 5825.883482330245, 5832.912506312494, 5843.824685259449, 3928.7249892507252, 3942.3692209246383, 3947.190825880745, 3948.9407658885716, 3951.92096158081, 5332.386775520865, 5416.539594134385, 5534.05920993424, 5549.445055494418, 5618.775248989995, 5312.946870531246, 5390.463717840396, 5393.24944278413, 5423.322084739408, 5438.728063596884, 5412.945870541402, 5418.539424148834, 5436.700981446058, 5481.342238931354, 5481.9036192762405, 5221.284931835348, 5366.0, 5367.631254030197, 5399.082156033405, 5409.540189083972, 5439.0, 5449.3188351456065, 5451.781928722965, 5460.945390546044, 5471.917921231265, 5285.814996475105, 5304.575633949352, 5332.760025798771, 5376.327959005124, 5376.677399356051], "value": 4091.6865293045935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.6690672650669, 783.3772151139843, 783.9137694853569, 805.0218983934519, 805.3825068527286, 14817.407303707852, 15643.687126257482, 15688.843111568882, 15695.764563531557, 15707.136107514083, 14893.851061489382, 15279.77080343793, 15416.0, 15421.614459638515, 15445.150516721576, 665.0987911380083, 792.8216151365954, 813.3086876155251, 817.7996390884211, 820.2248874813304, 818.6970820796314, 819.9631016604237, 821.6097353756977, 821.8890449789262, 822.1613953767154, 826.6652005937605, 827.0323721246157, 827.3133299361546, 828.3249151941179, 828.349745449822, 695.0512550368735, 824.8020475085966, 836.9539675317855, 847.6948298612556, 851.2381418630353, 638.0875348251998, 638.3488841381811, 638.5147288061107, 638.5466318913577, 638.6902352359102, 14902.254887255594, 14951.850481495154, 15035.924820375938, 15067.849321506865, 15071.849281507155, 13160.736785264337, 13205.537806176737, 13624.18254904699, 13690.178589284575, 13741.381637826322, 11115.388653624048, 11537.0, 11893.108016898766, 12409.813852792215, 12581.308028058453, 4274.5939135782055, 4290.914181716348, 4323.567643235683, 4331.7617531035785, 4356.390105385249, 75314.06910512647, 75577.62211188964, 76440.0, 76590.0, 77861.22138778596, 10541.333121978278, 10607.15142788575, 10702.571897124028, 11039.503222354853, 11124.332540047622, 19633.116509757096, 19872.0, 20114.497137571678, 20397.0, 20433.591328173352, 7539.246075392417, 7604.0, 7610.847783044308, 7651.732189373345, 7684.6157692116285, 4668.0, 4668.11305851887, 4673.275642275453, 4762.476127625959, 4804.855854324376, 3234.1267857678295, 3360.0927749507987, 3362.5628668272966, 3371.258323168899, 3379.6312493440196, 579.3511267380561, 580.054511146828, 582.8513728999078, 585.853536615846, 604.7006731667852, 630.8485963368759, 662.5556287293746, 675.3111825937516, 680.4658343200564, 692.2074225012433, 9847.704568862946, 10047.949760251153, 10497.265191436527, 10509.369437833602, 10686.73283167927, 676.2426082787309, 734.8052766017009, 740.5926740292817, 758.1925249609149, 763.7222034873332, 4199.790010499462, 4317.201317756225, 4442.466903971479, 4464.397306363664, 4468.642508599304, 96921.51539242259, 99232.0, 100880.49559752154, 117572.0, 121641.0, 57699.71150144222, 100771.49614252028, 101367.0, 102915.0, 102944.48527757313, 70120.64939675371, 82033.0, 85023.57488212519, 87088.0, 87941.0, 9109.726708198765, 9282.164605185566, 9350.719478415658, 9547.952260238655, 9552.0, 49950.0, 50010.74994625149, 50855.88017677454, 50878.49121508738, 51500.742496288774, 44005.77997109994, 60437.0, 75677.0, 75768.62115689386, 76073.23926760661, 11978.72404243191, 12119.0, 12131.0, 12246.816297755719, 12302.75394492123, 13771.517996870061, 14027.397260273972, 14084.15755596712, 14636.487722929647, 14971.850281497045, 13104.279264640156, 13145.671358216121, 13192.934035329761, 13731.24478153711, 14183.503577374742, 12900.096993210385, 13147.408366623333, 13258.071934964846, 13328.133671311334, 13727.382267797773, 13125.868741312846, 13207.867921320663, 13366.465341386236, 13517.59447216585, 14033.859661403256, 9377.156055954996, 9455.716328510156, 9501.0, 9603.327767056238, 9681.273904457054, 9318.69522448987, 9905.653302134391, 9940.801183976424, 10906.291091079054, 11134.164937629548], "value": 7341.101644719227, "unit": "score"}], "name": "dromaeo_css", "value": 7178.851412506029, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 111.0, 107.0, 111.0, 110.0, 110.0, 116.0, 110.0, 109.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 155.0, 180.0, 121.0, 141.0, 147.0, 121.0, 178.0, 116.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 168.0, 78.0, 76.0, 76.0, 75.0, 180.0, 76.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 154.0, 84.0, 84.0, 86.0, 151.0, 85.0, 84.0, 141.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 51.0, 53.0, 51.0, 52.0, 53.0, 52.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 85.0, 78.0, 81.0, 86.0, 81.0, 79.0, 86.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 126.0, 136.0, 146.0, 127.0, 147.0, 129.0, 151.0, 130.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 167.0, 165.0, 166.0, 171.0, 168.0, 164.0, 167.0, 165.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 65.0, 67.0, 66.0, 65.0, 64.0, 64.0, 67.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1530.5, "alertThreshold": 2.0}]} 16:44:03 INFO - Return code: 0 16:44:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:44:03 INFO - # TBPL SUCCESS # 16:44:03 INFO - Running post-action listener: _resource_record_post_action 16:44:03 INFO - [mozharness: 2016-08-21 23:44:03.481549Z] Finished run-tests step (success) 16:44:03 INFO - Running post-run listener: _resource_record_post_run 16:44:03 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 408121344; Read time: 352; Write time: 330804 16:44:03 INFO - TinderboxPrint: CPU usage
13.3% 16:44:03 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 352 16:44:03 INFO - TinderboxPrint: I/O write bytes / time
408,121,344 / 330,804 16:44:03 INFO - TinderboxPrint: CPU idle
8,280.2 (86.7%) 16:44:03 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 16:44:03 INFO - TinderboxPrint: Swap in / out
0 / 0 16:44:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118349824; Read time: 0; Write time: 103352 16:44:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289771520; Read time: 352; Write time: 227452 16:44:04 INFO - Running post-run listener: _upload_blobber_files 16:44:04 INFO - Blob upload gear active. 16:44:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:44:04 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 16:44:04 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:44:04 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:44:04 INFO - (blobuploader) - INFO - Open directory for files ... 16:44:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:44:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:44:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:05 INFO - (blobuploader) - INFO - Done attempting. 16:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:44:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:06 INFO - (blobuploader) - INFO - Done attempting. 16:44:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:44:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:44:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:09 INFO - (blobuploader) - INFO - Done attempting. 16:44:09 INFO - (blobuploader) - INFO - Iteration through files over. 16:44:09 INFO - Return code: 0 16:44:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:44:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:44:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7a1074f9cc54527c19d9793fe8e72f267941385d9331ef6172fc3f161b37651ad5086007a1e6e9b48db5f2fe6425d40b10801d6dcec49e5df3f4e9997293e1da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78d52bdac4f2d7406df5f0a368c202be3c5844a93a149986c508a33cd4094712ad41e4af8417c424ca6a9ae4e74167b1f8ae69bca85ed955d82cb2db3493b86f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/37e5d32db275d91ca2d034668742c0f15e3d2072a1e90c0678a86716c0881e7392ba78e442b156740fcb32990ee1e7bbc1919f6b3ac76c8aac99476a1687909c"} 16:44:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:44:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:44:09 INFO - Contents: 16:44:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7a1074f9cc54527c19d9793fe8e72f267941385d9331ef6172fc3f161b37651ad5086007a1e6e9b48db5f2fe6425d40b10801d6dcec49e5df3f4e9997293e1da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78d52bdac4f2d7406df5f0a368c202be3c5844a93a149986c508a33cd4094712ad41e4af8417c424ca6a9ae4e74167b1f8ae69bca85ed955d82cb2db3493b86f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/37e5d32db275d91ca2d034668742c0f15e3d2072a1e90c0678a86716c0881e7392ba78e442b156740fcb32990ee1e7bbc1919f6b3ac76c8aac99476a1687909c"} 16:44:09 INFO - Running post-run listener: copy_logs_to_upload_dir 16:44:09 INFO - Copying logs to upload dir... 16:44:09 INFO - mkdir: /builds/slave/test/build/upload/logs 16:44:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.098930 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-21 16:44:06.875951) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 16:44:06.879488) ========= 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=db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7a1074f9cc54527c19d9793fe8e72f267941385d9331ef6172fc3f161b37651ad5086007a1e6e9b48db5f2fe6425d40b10801d6dcec49e5df3f4e9997293e1da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78d52bdac4f2d7406df5f0a368c202be3c5844a93a149986c508a33cd4094712ad41e4af8417c424ca6a9ae4e74167b1f8ae69bca85ed955d82cb2db3493b86f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/37e5d32db275d91ca2d034668742c0f15e3d2072a1e90c0678a86716c0881e7392ba78e442b156740fcb32990ee1e7bbc1919f6b3ac76c8aac99476a1687909c"} build_url:https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011159 build_url: 'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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/Mozilla-Inbound/sha512/7a1074f9cc54527c19d9793fe8e72f267941385d9331ef6172fc3f161b37651ad5086007a1e6e9b48db5f2fe6425d40b10801d6dcec49e5df3f4e9997293e1da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78d52bdac4f2d7406df5f0a368c202be3c5844a93a149986c508a33cd4094712ad41e4af8417c424ca6a9ae4e74167b1f8ae69bca85ed955d82cb2db3493b86f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/37e5d32db275d91ca2d034668742c0f15e3d2072a1e90c0678a86716c0881e7392ba78e442b156740fcb32990ee1e7bbc1919f6b3ac76c8aac99476a1687909c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 16:44:06.905132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:44:06.905456) ========= 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=db7e7c15f3ca076d53731445000001ba-1471812939.537269-881112656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:44:06.990484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-21 16:44:06.990799) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-21 16:44:06.991100) ========= ========= Total master_lag: 0.17 =========