builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1470331874.64 results: success (0) buildid: 20160804100122 builduid: 3c60bd0de1954e3790cf1a140c38b888 revision: bbca4bc3ccd869d661cdcdbb801b4c82bd8aad24 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.642215) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.642839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.643230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.662600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.663038) ========= 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=4300f881736b422476174874000001bc-1470329670.398845-855975246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 10:31:14-- 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% 42.5M=0s 2016-08-04 10:31:14 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106856 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.786254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.786590) ========= 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=4300f881736b422476174874000001bc-1470329670.398845-855975246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016904 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.837560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.837941) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bbca4bc3ccd869d661cdcdbb801b4c82bd8aad24 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev bbca4bc3ccd869d661cdcdbb801b4c82bd8aad24 --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=4300f881736b422476174874000001bc-1470329670.398845-855975246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 10:31:15,113 truncating revision to first 12 chars 2016-08-04 10:31:15,113 Setting DEBUG logging. 2016-08-04 10:31:15,113 attempt 1/10 2016-08-04 10:31:15,113 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bbca4bc3ccd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 10:31:15,608 unpacking tar archive at: fx-team-bbca4bc3ccd8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.859248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:15.711120) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:15.711435) ========= script_repo_revision: bbca4bc3ccd869d661cdcdbb801b4c82bd8aad24 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:15.711842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:15.712128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:15.723343) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-04 10:31:15.723749) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1470329670.398845-855975246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:31:16 INFO - MultiFileLogger online at 20160804 10:31:16 in /builds/slave/test 10:31:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:31:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:31:16 INFO - {'append_to_log': False, 10:31:16 INFO - 'base_work_dir': '/builds/slave/test', 10:31:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:31:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:31:16 INFO - 'branch': 'Fx-Team-Non-PGO', 10:31:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:31:16 INFO - 'config_files': ('talos/linux_config.py',), 10:31:16 INFO - 'default_actions': ('clobber', 10:31:16 INFO - 'read-buildbot-config', 10:31:16 INFO - 'download-and-extract', 10:31:16 INFO - 'populate-webroot', 10:31:16 INFO - 'create-virtualenv', 10:31:16 INFO - 'install', 10:31:16 INFO - 'run-tests'), 10:31:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:31:16 INFO - 'download_minidump_stackwalk': True, 10:31:16 INFO - 'download_symbols': 'ondemand', 10:31:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:31:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:31:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:31:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:31:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:31:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:31:16 INFO - 'installer_path': 'installer.exe', 10:31:16 INFO - 'log_level': 'info', 10:31:16 INFO - 'log_name': 'talos', 10:31:16 INFO - 'log_to_console': True, 10:31:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:31:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:31:16 INFO - 'opt_config_files': (), 10:31:16 INFO - 'pip_index': False, 10:31:16 INFO - 'sps_profile': False, 10:31:16 INFO - 'sps_profile_interval': 0, 10:31:16 INFO - 'suite': 'dromaeojs', 10:31:16 INFO - 'system_bits': '32', 10:31:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:31:16 INFO - 'title': 'talos-linux64-ix-045', 10:31:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:31:16 INFO - 'use_talos_json': True, 10:31:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:31:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:31:16 INFO - 'work_dir': 'build'} 10:31:16 INFO - [mozharness: 2016-08-04 17:31:16.083546Z] Running clobber step. 10:31:16 INFO - Running pre-action listener: _resource_record_pre_action 10:31:16 INFO - Running main action method: clobber 10:31:16 INFO - rmtree: /builds/slave/test/build 10:31:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:31:16 INFO - Running post-action listener: _resource_record_post_action 10:31:16 INFO - [mozharness: 2016-08-04 17:31:16.540543Z] Finished clobber step (success) 10:31:16 INFO - [mozharness: 2016-08-04 17:31:16.540647Z] Running read-buildbot-config step. 10:31:16 INFO - Running pre-action listener: _resource_record_pre_action 10:31:16 INFO - Running main action method: read_buildbot_config 10:31:16 INFO - Using buildbot properties: 10:31:16 INFO - { 10:31:16 INFO - "project": "", 10:31:16 INFO - "product": "firefox", 10:31:16 INFO - "script_repo_revision": "production", 10:31:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:31:16 INFO - "repository": "", 10:31:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:31:16 INFO - "buildid": "20160804100122", 10:31:16 INFO - "pgo_build": "False", 10:31:16 INFO - "basedir": "/builds/slave/test", 10:31:16 INFO - "buildnumber": 1850, 10:31:16 INFO - "slavename": "talos-linux64-ix-045", 10:31:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:31:16 INFO - "platform": "ubuntu64_hw", 10:31:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:31:16 INFO - "branch": "fx-team", 10:31:16 INFO - "repo_path": "integration/fx-team", 10:31:16 INFO - "revision": "bbca4bc3ccd869d661cdcdbb801b4c82bd8aad24", 10:31:16 INFO - "stage_platform": "linux64", 10:31:16 INFO - "builduid": "3c60bd0de1954e3790cf1a140c38b888", 10:31:16 INFO - "slavebuilddir": "test" 10:31:16 INFO - } 10:31:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:31:16 INFO - Running post-action listener: _resource_record_post_action 10:31:16 INFO - [mozharness: 2016-08-04 17:31:16.543115Z] Finished read-buildbot-config step (success) 10:31:16 INFO - [mozharness: 2016-08-04 17:31:16.543205Z] Running download-and-extract step. 10:31:16 INFO - Running pre-action listener: _resource_record_pre_action 10:31:16 INFO - Running main action method: download_and_extract 10:31:16 INFO - mkdir: /builds/slave/test/build/tests 10:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:16 INFO - trying https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:31:16 INFO - Downloading https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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 10:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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 10:31:17 INFO - Downloaded 1361 bytes. 10:31:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:31:17 INFO - Using the following test package requirements: 10:31:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:31:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:31:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:31:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:17 INFO - u'jsshell-linux-x86_64.zip'], 10:31:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:31:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:31:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:31:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:31:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:31:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:31:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:31:17 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')]} 10:31:17 INFO - trying https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:31:17 INFO - Downloading https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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 10:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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 10:31:18 INFO - Downloaded 20249167 bytes. 10:31:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:31:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:31:19 INFO - Return code: 0 10:31:19 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 10:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:19 INFO - trying https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:31:19 INFO - Downloading https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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 10:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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 10:31:20 INFO - Downloaded 20249167 bytes. 10:31:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:31:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:31:21 INFO - Return code: 0 10:31:21 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')]} 10:31:21 INFO - trying https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:31:21 INFO - Downloading https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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 10:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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 10:31:24 INFO - Downloaded 14413723 bytes. 10:31:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:31:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:31:24 INFO - Return code: 0 10:31:24 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')]} 10:31:24 INFO - trying https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:31:24 INFO - Downloading https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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 10:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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 10:31:26 INFO - Downloaded 55515142 bytes. 10:31:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:31:27 INFO - mkdir: /builds/slave/test/properties 10:31:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:31:27 INFO - Writing to file /builds/slave/test/properties/build_url 10:31:27 INFO - Contents: 10:31:27 INFO - build_url:https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:31:27 INFO - Running post-action listener: _resource_record_post_action 10:31:27 INFO - Running post-action listener: set_extra_try_arguments 10:31:27 INFO - [mozharness: 2016-08-04 17:31:27.685063Z] Finished download-and-extract step (success) 10:31:27 INFO - [mozharness: 2016-08-04 17:31:27.685297Z] Running populate-webroot step. 10:31:27 INFO - Running pre-action listener: _resource_record_pre_action 10:31:27 INFO - Running main action method: populate_webroot 10:31:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:31:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:31:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:31:27 INFO - '--tppagecycles', 10:31:27 INFO - '7'], 10:31:27 INFO - 'tests': ['tsvgm']}}, 10:31:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:31:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:31:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:31:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:31:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:27 INFO - 'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:27 INFO - 'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['damp', 'tps']}, 10:31:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:27 INFO - 'tests': ['damp', 'tps']}, 10:31:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['dromaeo_dom']}, 10:31:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:31:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['basic_compositor_video']}, 10:31:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:31:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['a11yr', 10:31:27 INFO - 'ts_paint', 10:31:27 INFO - 'tpaint', 10:31:27 INFO - 'sessionrestore', 10:31:27 INFO - 'sessionrestore_no_auto_restore', 10:31:27 INFO - 'tabpaint']}, 10:31:27 INFO - 'other-e10s': {'tests': ['a11yr', 10:31:27 INFO - 'ts_paint', 10:31:27 INFO - 'tpaint', 10:31:27 INFO - 'sessionrestore', 10:31:27 INFO - 'sessionrestore_no_auto_restore', 10:31:27 INFO - 'tabpaint']}, 10:31:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:31:27 INFO - 'ts_paint', 10:31:27 INFO - 'tpaint', 10:31:27 INFO - 'sessionrestore', 10:31:27 INFO - 'sessionrestore_no_auto_restore', 10:31:27 INFO - 'tabpaint']}, 10:31:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:31:27 INFO - 'ts_paint', 10:31:27 INFO - 'tpaint', 10:31:27 INFO - 'sessionrestore', 10:31:27 INFO - 'sessionrestore_no_auto_restore', 10:31:27 INFO - 'tabpaint']}, 10:31:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['a11yr', 10:31:27 INFO - 'ts_paint', 10:31:27 INFO - 'tpaint', 10:31:27 INFO - 'sessionrestore', 10:31:27 INFO - 'sessionrestore_no_auto_restore', 10:31:27 INFO - 'tabpaint']}, 10:31:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['a11yr', 10:31:27 INFO - 'ts_paint', 10:31:27 INFO - 'tpaint', 10:31:27 INFO - 'sessionrestore', 10:31:27 INFO - 'sessionrestore_no_auto_restore', 10:31:27 INFO - 'tabpaint']}, 10:31:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['tsvgx', 10:31:27 INFO - 'tsvgr_opacity', 10:31:27 INFO - 'tart', 10:31:27 INFO - 'tscrollx', 10:31:27 INFO - 'cart']}, 10:31:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:31:27 INFO - 'tsvgr_opacity', 10:31:27 INFO - 'tart', 10:31:27 INFO - 'tscrollx', 10:31:27 INFO - 'cart']}, 10:31:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:27 INFO - 'talos_options': ['--disable-e10s'], 10:31:27 INFO - 'tests': ['tp5o']}, 10:31:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:27 INFO - 'tests': ['tp5o']}, 10:31:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:27 INFO - 'talos_options': ['--disable-e10s', 10:31:27 INFO - '--xperf_path', 10:31:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:27 INFO - 'tests': ['tp5n']}, 10:31:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:27 INFO - 'talos_options': ['--xperf_path', 10:31:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:27 INFO - 'tests': ['tp5n']}}, 10:31:27 INFO - 'talos.zip': {'path': '', 10:31:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:31:27 INFO - Running post-action listener: _resource_record_post_action 10:31:27 INFO - [mozharness: 2016-08-04 17:31:27.707214Z] Finished populate-webroot step (success) 10:31:27 INFO - [mozharness: 2016-08-04 17:31:27.707303Z] Running create-virtualenv step. 10:31:27 INFO - Running pre-action listener: _resource_record_pre_action 10:31:27 INFO - Running main action method: create_virtualenv 10:31:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:31:27 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 10:31:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:31:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:31:27 INFO - Using real prefix '/usr' 10:31:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:31:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:31:30 INFO - Installing pip.................done. 10:31:30 INFO - Return code: 0 10:31:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:31: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')]} 10:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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')]} 10:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:30 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, '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': '4300f881736b422476174874000001bc-1470329670.398845-855975246', '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 10:31:30 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 10:31:30 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 10:31:30 INFO - Using env: {'DISPLAY': ':0', 10:31:30 INFO - 'HOME': '/home/cltbld', 10:31:30 INFO - 'LANG': 'en_US.UTF-8', 10:31:30 INFO - 'LANGUAGE': 'en_US:en', 10:31:30 INFO - 'LOGNAME': 'cltbld', 10:31:30 INFO - 'MAIL': '/var/mail/cltbld', 10:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:30 INFO - 'MOZ_NO_REMOTE': '1', 10:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:30 INFO - 'NO_EM_RESTART': '1', 10:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:30 INFO - 'PWD': '/builds/slave/test', 10:31:30 INFO - 'SHELL': '/bin/bash', 10:31:30 INFO - 'SHLVL': '1', 10:31:30 INFO - 'TERM': 'linux', 10:31:30 INFO - 'TMOUT': '86400', 10:31:30 INFO - 'USER': 'cltbld', 10:31:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:30 INFO - '_': '/tools/buildbot/bin/python'} 10:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:30 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 10:31:30 INFO - Cleaning up... 10:31:30 INFO - Return code: 0 10:31:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:31: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')]} 10:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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')]} 10:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:30 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, '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': '4300f881736b422476174874000001bc-1470329670.398845-855975246', '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 10:31:30 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 10:31:30 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 10:31:30 INFO - Using env: {'DISPLAY': ':0', 10:31:30 INFO - 'HOME': '/home/cltbld', 10:31:30 INFO - 'LANG': 'en_US.UTF-8', 10:31:30 INFO - 'LANGUAGE': 'en_US:en', 10:31:30 INFO - 'LOGNAME': 'cltbld', 10:31:30 INFO - 'MAIL': '/var/mail/cltbld', 10:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:30 INFO - 'MOZ_NO_REMOTE': '1', 10:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:30 INFO - 'NO_EM_RESTART': '1', 10:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:30 INFO - 'PWD': '/builds/slave/test', 10:31:30 INFO - 'SHELL': '/bin/bash', 10:31:30 INFO - 'SHLVL': '1', 10:31:30 INFO - 'TERM': 'linux', 10:31:30 INFO - 'TMOUT': '86400', 10:31:30 INFO - 'USER': 'cltbld', 10:31:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:30 INFO - '_': '/tools/buildbot/bin/python'} 10:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:30 INFO - Downloading/unpacking psutil>=3.1.1 10:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:31:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:32 INFO - Installing collected packages: psutil 10:31:32 INFO - Running setup.py install for psutil 10:31:32 INFO - building 'psutil._psutil_linux' extension 10:31:32 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 10:31:32 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 10:31:32 INFO - building 'psutil._psutil_posix' extension 10:31:32 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 10:31:33 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 10:31:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:33 INFO - Successfully installed psutil 10:31:33 INFO - Cleaning up... 10:31:33 INFO - Return code: 0 10:31:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, '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': '4300f881736b422476174874000001bc-1470329670.398845-855975246', '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 10:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:31:33 INFO - Using env: {'DISPLAY': ':0', 10:31:33 INFO - 'HOME': '/home/cltbld', 10:31:33 INFO - 'LANG': 'en_US.UTF-8', 10:31:33 INFO - 'LANGUAGE': 'en_US:en', 10:31:33 INFO - 'LOGNAME': 'cltbld', 10:31:33 INFO - 'MAIL': '/var/mail/cltbld', 10:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:33 INFO - 'MOZ_NO_REMOTE': '1', 10:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:33 INFO - 'NO_EM_RESTART': '1', 10:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:33 INFO - 'PWD': '/builds/slave/test', 10:31:33 INFO - 'SHELL': '/bin/bash', 10:31:33 INFO - 'SHLVL': '1', 10:31:33 INFO - 'TERM': 'linux', 10:31:33 INFO - 'TMOUT': '86400', 10:31:33 INFO - 'USER': 'cltbld', 10:31:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:33 INFO - '_': '/tools/buildbot/bin/python'} 10:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:31:35 INFO - Installing collected packages: mozsystemmonitor 10:31:35 INFO - Running setup.py install for mozsystemmonitor 10:31:35 INFO - Successfully installed mozsystemmonitor 10:31:35 INFO - Cleaning up... 10:31:35 INFO - Return code: 0 10:31:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:31: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')]} 10:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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')]} 10:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:35 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, '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': '4300f881736b422476174874000001bc-1470329670.398845-855975246', '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 10:31:35 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 10:31:35 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 10:31:35 INFO - Using env: {'DISPLAY': ':0', 10:31:35 INFO - 'HOME': '/home/cltbld', 10:31:35 INFO - 'LANG': 'en_US.UTF-8', 10:31:35 INFO - 'LANGUAGE': 'en_US:en', 10:31:35 INFO - 'LOGNAME': 'cltbld', 10:31:35 INFO - 'MAIL': '/var/mail/cltbld', 10:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:35 INFO - 'MOZ_NO_REMOTE': '1', 10:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:35 INFO - 'NO_EM_RESTART': '1', 10:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:35 INFO - 'PWD': '/builds/slave/test', 10:31:35 INFO - 'SHELL': '/bin/bash', 10:31:35 INFO - 'SHLVL': '1', 10:31:35 INFO - 'TERM': 'linux', 10:31:35 INFO - 'TMOUT': '86400', 10:31:35 INFO - 'USER': 'cltbld', 10:31:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:35 INFO - '_': '/tools/buildbot/bin/python'} 10:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:35 INFO - Downloading/unpacking jsonschema==2.5.1 10:31:35 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 10:31:35 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 10:31:35 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 10:31:35 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 10:31:35 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 10:31:35 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 10:31:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:31:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:37 INFO - Downloading functools32-3.2.3-2.tar.gz 10:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:31:37 INFO - warning: no files found matching '*.txt' 10:31:37 INFO - no previously-included directories found matching 'build' 10:31:37 INFO - no previously-included directories found matching 'dist' 10:31:37 INFO - no previously-included directories found matching '.git*' 10:31:37 INFO - Installing collected packages: jsonschema, functools32 10:31:37 INFO - Running setup.py install for functools32 10:31:38 INFO - warning: no files found matching '*.txt' 10:31:38 INFO - no previously-included directories found matching 'build' 10:31:38 INFO - no previously-included directories found matching 'dist' 10:31:38 INFO - no previously-included directories found matching '.git*' 10:31:38 INFO - Successfully installed jsonschema functools32 10:31:38 INFO - Cleaning up... 10:31:38 INFO - Return code: 0 10:31:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:38 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, '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': '4300f881736b422476174874000001bc-1470329670.398845-855975246', '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 10:31:38 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 10:31:38 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 10:31:38 INFO - Using env: {'DISPLAY': ':0', 10:31:38 INFO - 'HOME': '/home/cltbld', 10:31:38 INFO - 'LANG': 'en_US.UTF-8', 10:31:38 INFO - 'LANGUAGE': 'en_US:en', 10:31:38 INFO - 'LOGNAME': 'cltbld', 10:31:38 INFO - 'MAIL': '/var/mail/cltbld', 10:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:38 INFO - 'MOZ_NO_REMOTE': '1', 10:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:38 INFO - 'NO_EM_RESTART': '1', 10:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:38 INFO - 'PWD': '/builds/slave/test', 10:31:38 INFO - 'SHELL': '/bin/bash', 10:31:38 INFO - 'SHLVL': '1', 10:31:38 INFO - 'TERM': 'linux', 10:31:38 INFO - 'TMOUT': '86400', 10:31:38 INFO - 'USER': 'cltbld', 10:31:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:38 INFO - '_': '/tools/buildbot/bin/python'} 10:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:31:38 INFO - Cleaning up... 10:31:38 INFO - Return code: 0 10:31:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:38 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, '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': '4300f881736b422476174874000001bc-1470329670.398845-855975246', '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 10:31:38 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 10:31:38 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 10:31:38 INFO - Using env: {'DISPLAY': ':0', 10:31:38 INFO - 'HOME': '/home/cltbld', 10:31:38 INFO - 'LANG': 'en_US.UTF-8', 10:31:38 INFO - 'LANGUAGE': 'en_US:en', 10:31:38 INFO - 'LOGNAME': 'cltbld', 10:31:38 INFO - 'MAIL': '/var/mail/cltbld', 10:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:38 INFO - 'MOZ_NO_REMOTE': '1', 10:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:38 INFO - 'NO_EM_RESTART': '1', 10:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:38 INFO - 'PWD': '/builds/slave/test', 10:31:38 INFO - 'SHELL': '/bin/bash', 10:31:38 INFO - 'SHLVL': '1', 10:31:38 INFO - 'TERM': 'linux', 10:31:38 INFO - 'TMOUT': '86400', 10:31:38 INFO - 'USER': 'cltbld', 10:31:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:38 INFO - '_': '/tools/buildbot/bin/python'} 10:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:38 INFO - Downloading/unpacking blobuploader==1.2.4 10:31:38 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 10:31:38 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 10:31:38 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 10:31:38 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 10:31:38 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 10:31:38 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 10:31:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:31:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:31:40 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 10:31:40 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 10:31:40 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 10:31:40 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 10:31:40 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 10:31:40 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 10:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:31:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:31:40 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 10:31:40 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 10:31:40 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 10:31:40 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 10:31:40 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 10:31:40 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 10:31:41 INFO - Downloading docopt-0.6.1.tar.gz 10:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:31:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:31:41 INFO - Running setup.py install for blobuploader 10:31:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:31:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:31:41 INFO - Running setup.py install for requests 10:31:41 INFO - Running setup.py install for docopt 10:31:41 INFO - Successfully installed blobuploader requests docopt 10:31:41 INFO - Cleaning up... 10:31:42 INFO - Return code: 0 10:31:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:42 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, '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': '4300f881736b422476174874000001bc-1470329670.398845-855975246', '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 10:31:42 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 10:31:42 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 10:31:42 INFO - Using env: {'DISPLAY': ':0', 10:31:42 INFO - 'HOME': '/home/cltbld', 10:31:42 INFO - 'LANG': 'en_US.UTF-8', 10:31:42 INFO - 'LANGUAGE': 'en_US:en', 10:31:42 INFO - 'LOGNAME': 'cltbld', 10:31:42 INFO - 'MAIL': '/var/mail/cltbld', 10:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:42 INFO - 'MOZ_NO_REMOTE': '1', 10:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:42 INFO - 'NO_EM_RESTART': '1', 10:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:42 INFO - 'PWD': '/builds/slave/test', 10:31:42 INFO - 'SHELL': '/bin/bash', 10:31:42 INFO - 'SHLVL': '1', 10:31:42 INFO - 'TERM': 'linux', 10:31:42 INFO - 'TMOUT': '86400', 10:31:42 INFO - 'USER': 'cltbld', 10:31:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:42 INFO - '_': '/tools/buildbot/bin/python'} 10:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:42 INFO - Running setup.py (path:/tmp/pip-5GzJqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:42 INFO - Running setup.py (path:/tmp/pip-hftfQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:42 INFO - Running setup.py (path:/tmp/pip-2tBJpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:42 INFO - Running setup.py (path:/tmp/pip-9fTvFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:42 INFO - Running setup.py (path:/tmp/pip-80knlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:42 INFO - Running setup.py (path:/tmp/pip-FHxqoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:42 INFO - Running setup.py (path:/tmp/pip-L2hgHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:42 INFO - Running setup.py (path:/tmp/pip-ZrFqji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:42 INFO - Running setup.py (path:/tmp/pip-eWRTkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:42 INFO - Running setup.py (path:/tmp/pip-IneBFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:42 INFO - Running setup.py (path:/tmp/pip-Bt0SkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:43 INFO - Running setup.py (path:/tmp/pip-JHFylN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:43 INFO - Running setup.py (path:/tmp/pip-E7WsyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:43 INFO - Running setup.py (path:/tmp/pip-LvR3DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:43 INFO - Running setup.py (path:/tmp/pip-Dm0NUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:43 INFO - Running setup.py (path:/tmp/pip-S_tI1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:43 INFO - Running setup.py (path:/tmp/pip-IPcWUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:31:43 INFO - Running setup.py install for manifestparser 10:31:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:31:43 INFO - Running setup.py install for mozcrash 10:31:43 INFO - Running setup.py install for mozdebug 10:31:43 INFO - Running setup.py install for mozdevice 10:31:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:31:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:31:43 INFO - Running setup.py install for mozfile 10:31:43 INFO - Running setup.py install for mozhttpd 10:31:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Running setup.py install for mozinfo 10:31:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Running setup.py install for mozInstall 10:31:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Running setup.py install for mozleak 10:31:44 INFO - Running setup.py install for mozlog 10:31:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Running setup.py install for moznetwork 10:31:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Running setup.py install for mozprocess 10:31:44 INFO - Running setup.py install for mozprofile 10:31:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Running setup.py install for mozrunner 10:31:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:31:44 INFO - Running setup.py install for mozscreenshot 10:31:45 INFO - Running setup.py install for moztest 10:31:45 INFO - Running setup.py install for mozversion 10:31:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:31:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:31:45 INFO - Cleaning up... 10:31:45 INFO - Return code: 0 10:31:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:45 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')]} 10:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:45 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')]} 10:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:45 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, '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': '4300f881736b422476174874000001bc-1470329670.398845-855975246', '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 10:31:45 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 10:31:45 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 10:31:45 INFO - Using env: {'DISPLAY': ':0', 10:31:45 INFO - 'HOME': '/home/cltbld', 10:31:45 INFO - 'LANG': 'en_US.UTF-8', 10:31:45 INFO - 'LANGUAGE': 'en_US:en', 10:31:45 INFO - 'LOGNAME': 'cltbld', 10:31:45 INFO - 'MAIL': '/var/mail/cltbld', 10:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:45 INFO - 'MOZ_NO_REMOTE': '1', 10:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:45 INFO - 'NO_EM_RESTART': '1', 10:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:45 INFO - 'PWD': '/builds/slave/test', 10:31:45 INFO - 'SHELL': '/bin/bash', 10:31:45 INFO - 'SHLVL': '1', 10:31:45 INFO - 'TERM': 'linux', 10:31:45 INFO - 'TMOUT': '86400', 10:31:45 INFO - 'USER': 'cltbld', 10:31:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:45 INFO - '_': '/tools/buildbot/bin/python'} 10:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:45 INFO - Running setup.py (path:/tmp/pip-W4FuxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:45 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)) 10:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:45 INFO - Running setup.py (path:/tmp/pip-bKnA0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:45 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)) 10:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:45 INFO - Running setup.py (path:/tmp/pip-oSwhIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:45 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)) 10:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:45 INFO - Running setup.py (path:/tmp/pip-d4tigP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:45 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)) 10:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:45 INFO - Running setup.py (path:/tmp/pip-0os4id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:45 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)) 10:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:45 INFO - Running setup.py (path:/tmp/pip-WvUzVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:45 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)) 10:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:45 INFO - Running setup.py (path:/tmp/pip-kZpN4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:45 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)) 10:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:45 INFO - Running setup.py (path:/tmp/pip-OnLsSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:46 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)) 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:46 INFO - Running setup.py (path:/tmp/pip-eYEPwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:46 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)) 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:46 INFO - Running setup.py (path:/tmp/pip-R0fAyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:46 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)) 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:46 INFO - Running setup.py (path:/tmp/pip-zEdeeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:46 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)) 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:46 INFO - Running setup.py (path:/tmp/pip-UPF6IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:46 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)) 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:46 INFO - Running setup.py (path:/tmp/pip-Ycx9gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:46 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)) 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:46 INFO - Running setup.py (path:/tmp/pip-UsN13J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:46 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)) 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:46 INFO - Running setup.py (path:/tmp/pip-KvBGRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:46 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)) 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:46 INFO - Running setup.py (path:/tmp/pip-tI89zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:46 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)) 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:46 INFO - Running setup.py (path:/tmp/pip-TBc4tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:46 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)) 10:31:46 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)) 10:31:46 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)) 10:31:46 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)) 10:31:46 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)) 10:31:46 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)) 10:31:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:31:46 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 10:31:46 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 10:31:46 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 10:31:46 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 10:31:46 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 10:31:46 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 10:31:48 INFO - Downloading blessings-1.6.tar.gz 10:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:31:48 INFO - Installing collected packages: blessings 10:31:48 INFO - Running setup.py install for blessings 10:31:48 INFO - Successfully installed blessings 10:31:48 INFO - Cleaning up... 10:31:48 INFO - Return code: 0 10:31:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:49 INFO - Reading from file tmpfile_stdout 10:31:49 INFO - Current package versions: 10:31:49 INFO - argparse == 1.2.1 10:31:49 INFO - blessings == 1.6 10:31:49 INFO - blobuploader == 1.2.4 10:31:49 INFO - docopt == 0.6.1 10:31:49 INFO - functools32 == 3.2.3-2 10:31:49 INFO - jsonschema == 2.5.1 10:31:49 INFO - manifestparser == 1.1 10:31:49 INFO - mozInstall == 1.12 10:31:49 INFO - mozcrash == 0.17 10:31:49 INFO - mozdebug == 0.1 10:31:49 INFO - mozdevice == 0.48 10:31:49 INFO - mozfile == 1.2 10:31:49 INFO - mozhttpd == 0.7 10:31:49 INFO - mozinfo == 0.9 10:31:49 INFO - mozleak == 0.1 10:31:49 INFO - mozlog == 3.3 10:31:49 INFO - moznetwork == 0.27 10:31:49 INFO - mozprocess == 0.23 10:31:49 INFO - mozprofile == 0.28 10:31:49 INFO - mozrunner == 6.12 10:31:49 INFO - mozscreenshot == 0.1 10:31:49 INFO - mozsystemmonitor == 0.3 10:31:49 INFO - moztest == 0.7 10:31:49 INFO - mozversion == 1.4 10:31:49 INFO - psutil == 3.1.1 10:31:49 INFO - requests == 1.2.3 10:31:49 INFO - wsgiref == 0.1.2 10:31:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31: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')]} 10:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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')]} 10:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:49 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, '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': '4300f881736b422476174874000001bc-1470329670.398845-855975246', '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 10:31:49 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 10:31:49 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 10:31:49 INFO - Using env: {'DISPLAY': ':0', 10:31:49 INFO - 'HOME': '/home/cltbld', 10:31:49 INFO - 'LANG': 'en_US.UTF-8', 10:31:49 INFO - 'LANGUAGE': 'en_US:en', 10:31:49 INFO - 'LOGNAME': 'cltbld', 10:31:49 INFO - 'MAIL': '/var/mail/cltbld', 10:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:49 INFO - 'MOZ_NO_REMOTE': '1', 10:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:49 INFO - 'NO_EM_RESTART': '1', 10:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:49 INFO - 'PWD': '/builds/slave/test', 10:31:49 INFO - 'SHELL': '/bin/bash', 10:31:49 INFO - 'SHLVL': '1', 10:31:49 INFO - 'TERM': 'linux', 10:31:49 INFO - 'TMOUT': '86400', 10:31:49 INFO - 'USER': 'cltbld', 10:31:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:49 INFO - '_': '/tools/buildbot/bin/python'} 10:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:49 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)) 10:31:49 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)) 10:31:49 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)) 10:31:49 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)) 10:31:49 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)) 10:31:49 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)) 10:31:49 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)) 10:31:49 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)) 10:31:49 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)) 10:31:49 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)) 10:31:49 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)) 10:31:49 INFO - Cleaning up... 10:31:49 INFO - Return code: 0 10:31:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:31: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')]} 10:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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')]} 10:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, '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': '4300f881736b422476174874000001bc-1470329670.398845-855975246', '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 10:31: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', 'jsonschema'] in /builds/slave/test/build 10:31: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 jsonschema 10:31:49 INFO - Using env: {'DISPLAY': ':0', 10:31:49 INFO - 'HOME': '/home/cltbld', 10:31:49 INFO - 'LANG': 'en_US.UTF-8', 10:31:49 INFO - 'LANGUAGE': 'en_US:en', 10:31:49 INFO - 'LOGNAME': 'cltbld', 10:31:49 INFO - 'MAIL': '/var/mail/cltbld', 10:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:49 INFO - 'MOZ_NO_REMOTE': '1', 10:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:49 INFO - 'NO_EM_RESTART': '1', 10:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:49 INFO - 'PWD': '/builds/slave/test', 10:31:49 INFO - 'SHELL': '/bin/bash', 10:31:49 INFO - 'SHLVL': '1', 10:31:49 INFO - 'TERM': 'linux', 10:31:49 INFO - 'TMOUT': '86400', 10:31:49 INFO - 'USER': 'cltbld', 10:31:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:49 INFO - '_': '/tools/buildbot/bin/python'} 10:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:31:49 INFO - Cleaning up... 10:31:49 INFO - Return code: 0 10:31:49 INFO - Running post-action listener: _resource_record_post_action 10:31:49 INFO - Running post-action listener: _start_resource_monitoring 10:31:49 INFO - Starting resource monitoring. 10:31:49 INFO - [mozharness: 2016-08-04 17:31:49.547817Z] Finished create-virtualenv step (success) 10:31:49 INFO - [mozharness: 2016-08-04 17:31:49.548308Z] Running install step. 10:31:49 INFO - Running pre-action listener: _resource_record_pre_action 10:31:49 INFO - Running main action method: install 10:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:49 INFO - Reading from file tmpfile_stdout 10:31:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:31:49 INFO - Reading from file tmpfile_stdout 10:31:49 INFO - Output received: 10:31:49 INFO - Usage: mozinstall [options] installer 10:31:49 INFO - Options: 10:31:49 INFO - -h, --help show this help message and exit 10:31:49 INFO - -d DEST, --destination=DEST 10:31:49 INFO - Directory to install application into. [default: 10:31:49 INFO - "/builds/slave/test"] 10:31:49 INFO - --app=APP Application being installed. [default: firefox] 10:31:49 INFO - mkdir: /builds/slave/test/build/application 10:31:49 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'] 10:31:49 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 10:32:05 INFO - Reading from file tmpfile_stdout 10:32:05 INFO - Output received: 10:32:05 INFO - /builds/slave/test/build/application/firefox/firefox 10:32:05 INFO - Running post-action listener: _resource_record_post_action 10:32:05 INFO - [mozharness: 2016-08-04 17:32:05.858011Z] Finished install step (success) 10:32:05 INFO - [mozharness: 2016-08-04 17:32:05.858348Z] Running run-tests step. 10:32:05 INFO - Running pre-action listener: _resource_record_pre_action 10:32:05 INFO - Running main action method: run_tests 10:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:32:05 INFO - Python 2.7.3 10:32:05 INFO - Return code: 0 10:32:05 INFO - grabbing minidump binary from tooltool 10:32: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')]} 10:32:05 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 0x17e33b0>, '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 0x17e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:32:05 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 10:32:05 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 10:32:05 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 10:32:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:32:05 INFO - Return code: 0 10:32:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:32:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:32:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:32:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:32:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 10:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 10:32:05 INFO - Using env: {'DISPLAY': ':0', 10:32:05 INFO - 'HOME': '/home/cltbld', 10:32:05 INFO - 'LANG': 'en_US.UTF-8', 10:32:05 INFO - 'LANGUAGE': 'en_US:en', 10:32:05 INFO - 'LOGNAME': 'cltbld', 10:32:05 INFO - 'MAIL': '/var/mail/cltbld', 10:32:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:32:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:05 INFO - 'MOZ_NO_REMOTE': '1', 10:32:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:05 INFO - 'NO_EM_RESTART': '1', 10:32:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:05 INFO - 'PWD': '/builds/slave/test', 10:32:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:32:05 INFO - 'SHELL': '/bin/bash', 10:32:05 INFO - 'SHLVL': '1', 10:32:05 INFO - 'TERM': 'linux', 10:32:05 INFO - 'TMOUT': '86400', 10:32:05 INFO - 'USER': 'cltbld', 10:32:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470329670.398845-855975246', 10:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:05 INFO - '_': '/tools/buildbot/bin/python'} 10:32:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 10:32:06 INFO - mozversion application_buildid: 20160804100122 10:32:06 INFO - mozversion application_changeset: bbca4bc3ccd869d661cdcdbb801b4c82bd8aad24 10:32:06 INFO - mozversion application_display_name: Nightly 10:32:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:32:06 INFO - mozversion application_name: Firefox 10:32:06 INFO - mozversion application_remotingname: firefox 10:32:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:32:06 INFO - mozversion application_vendor: Mozilla 10:32:06 INFO - mozversion application_version: 51.0a1 10:32:06 INFO - mozversion platform_buildid: 20160804100122 10:32:06 INFO - mozversion platform_changeset: bbca4bc3ccd869d661cdcdbb801b4c82bd8aad24 10:32:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:32:06 INFO - mozversion platform_version: 51.0a1 10:32:06 INFO - using testdate: 1470331926 10:32:06 INFO - actual date: 1470331926 10:32:06 INFO - starting webserver on 'localhost:48846' 10:32:06 INFO - SUITE-START | Running 2 tests 10:32:06 INFO - TEST-START | dromaeo_css 10:32:06 INFO - operating with platform_type : linux_ 10:32:06 INFO - Initialising browser for dromaeo_css test... 10:32:06 INFO - TEST-INFO | started process 16912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN4bz3s/profile http://localhost:48846/getInfo.html) 10:32:10 INFO - PROCESS | 16912 | __metrics Screen width/height:1600/1200 10:32:10 INFO - PROCESS | 16912 | colorDepth:24 10:32:10 INFO - PROCESS | 16912 | Browser inner width/height: 1024/697 10:32:10 INFO - PROCESS | 16912 | __metrics 10:32:11 INFO - PROCESS | 16912 | 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" 10:32:11 INFO - PROCESS | 16912 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:32:11 INFO - PROCESS | 16912 | console.error: PushService: 10:32:11 INFO - PROCESS | 16912 | stateChangeProcessEnqueue: Error transitioning state 10:32:11 INFO - PROCESS | 16912 | UnknownError 10:32:12 INFO - TEST-INFO | 16912: exit 0 10:32:12 INFO - Browser initialized. 10:32:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:32:12 INFO - TEST-INFO | started process 16991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN4bz3s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:24 INFO - PROCESS | 16991 | RSS: Main: 156778496 10:32:24 INFO - PROCESS | 16991 | 10:33:15 INFO - PROCESS | 16991 | 1470331995500 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] 10:35:28 INFO - PROCESS | 16991 | Cycle 1(1): loaded http://localhost:48846/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48846/tests/dromaeo/cssquery-ext.html) 10:35:29 INFO - PROCESS | 16991 | RSS: Main: 248770560 10:35:29 INFO - PROCESS | 16991 | 10:38:32 INFO - PROCESS | 16991 | Cycle 1(1): loaded http://localhost:48846/tests/dromaeo/cssquery-ext.html (next: http://localhost:48846/tests/dromaeo/cssquery-jquery.html) 10:38:32 INFO - PROCESS | 16991 | RSS: Main: 241942528 10:38:32 INFO - PROCESS | 16991 | 10:41:35 INFO - PROCESS | 16991 | Cycle 1(1): loaded http://localhost:48846/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48846/tests/dromaeo/cssquery-mootools.html) 10:41:35 INFO - PROCESS | 16991 | RSS: Main: 217305088 10:41:35 INFO - PROCESS | 16991 | 10:44:37 INFO - PROCESS | 16991 | Cycle 1(1): loaded http://localhost:48846/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48846/tests/dromaeo/cssquery-prototype.html) 10:44:38 INFO - PROCESS | 16991 | RSS: Main: 192245760 10:44:38 INFO - PROCESS | 16991 | 10:47:41 INFO - PROCESS | 16991 | Cycle 1(1): loaded http://localhost:48846/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48846/tests/dromaeo/cssquery-yui.html) 10:47:41 INFO - PROCESS | 16991 | RSS: Main: 188813312 10:47:41 INFO - PROCESS | 16991 | 10:50:44 INFO - PROCESS | 16991 | Cycle 1(1): loaded http://localhost:48846/tests/dromaeo/cssquery-yui.html (next: http://localhost:48846/tests/dromaeo/cssquery-dojo.html) 10:50:45 INFO - PROCESS | 16991 | RSS: Main: 279068672 10:50:45 INFO - PROCESS | 16991 | 10:50:45 INFO - PROCESS | 16991 | __start_tp_report 10:50:45 INFO - PROCESS | 16991 | _x_x_mozilla_page_load 10:50:45 INFO - PROCESS | 16991 | _x_x_mozilla_page_load_details 10:50:45 INFO - PROCESS | 16991 | |i|pagename|runs| 10:50:45 INFO - PROCESS | 16991 | |0;dojo.html;2659.348459627391;2663.920082397529;2689.381442268278;2702.297402675304;2710.1733971138806;4645.094206629708;4729.408823897013;4801.255805350168;4958.08275469038;4963.503649635035;4778.259369797678;4796.184648609736;4811.903761924759;4816.422029356482;4865.756712164386;4389.780510974447;4404.339349097645;4477.238869392195;4533.093381323732;4598.747068911225;4510.954890451087;4545.909081818361;4561.315802629599;4572.039871626962;4586.266197408415;4328.523862375137;4371.34429835524;4380.364847097153;4398.978005109986;4483.461984561841;4423.845165419195;4427.313766366218;4434.401355816955;4437.622802061796;4510.052888893337;4459.799309031101;4460.197164510387;4476.216662084123;4505.977470112662;4513.142502924434;4698.812047518095;4742.762861856893;4850.6362022848425;4860.635452341053;4911.607071434277;5138.7173705446185;5178.792848286064;5224.242484839677;5237.266782650432;5237.3453318335205;5212.791488340462;5214.713190774506;5248.160294352885;5248.973755131238;5262.02652509287;4678.157931572282;4805.27920811874;4860.295257187759;4869.586085182799;4895.6083513318845;5340.893182136336;5362.785488580491;5402.972985135049;5411.918821217685;5415.891682166334;5133.512316329943;5178.741062946838;5187.688738675692;5187.740612969336;5191.97404012985;5040.7731652075745;5096.337476128154;5126.641135120506;5224.373075230997;5286.233496143038;5146.253793199965;5147.716875571879;5151.6136289778415;5181.35233095863;5186.196139598293;5109.693418394834;5110.3356563646485;5117.385913690307;5127.692338459629;5169.121249387613;4313.590208930146;4367.868963931087;4369.978150109293;4441.222786012435;4500.639948804088;3824.2351529694174;3846.3461211593535;3887;3934.272159650474;3940.1922605866303;4390.407295015196;4393.714408563433;4396.098799746044;4397.054633253866;4436.423264975532;5012.974935125301;5057.873553161126;5167.159653003932;5183.870403239874;5237.764300606482;4336.848210312624;4382.649388048949;4388.319810429389;4432.756198409118;4452.9554704453185;4674.953250467452;4679.906401872012;4681.110588988081;4688.859334219979;4732.077244937204;4820.25286080658;4843.4430040545085;4868.172410690262;4869.732164730974;4910.975445122752;5007.24891266313;5130.51260130287;5178.870528236825;5179.92230116541;5285.735713214247;4885.364902562644;4888.706677599355;4897.094037603055;4899.779509922133;4931.3096166536;5113.565346945403;5120.078385890575;5125.2568377585785;5126.333576635014;5127.692338459704;5052.8484145475695;5087.033463641897;5116.079105760999;5133.204353325241;5230.084735171406;5008.398992120969;5010.398752149766;5020.748962551931;5020.849374518771;5076.137056700296;4987.825426110214;5009.474005229544;5011.9498805012945;5014.774335154853;5037.722925239147;4785.066911952136;4888.92666609994;4965.4289756678445;4968.27959945813;5060.139776237975;5084.542391184811;5107.565856902205;5112.590992720648;5114.411842638145;5150.304708864255;4981.252812078217;4984.6261530384645;4986.47641997585;4987.027529631687;4991.026749783902 10:50:45 INFO - PROCESS | 16991 | |1;ext.html;551.9834404967851;574.971251437428;579.5653260054959;579.9913001304981;580.3181262017129;27625.723742762566;30646.241838234582;37060.44409333862;38581.228375432474;38789.41815872764;39550.60449395505;40045.39931901017;40081;40093.59906400935;40254.798726006404;7617.619119044053;7749;7754.379649628045;7755.340796032316;7759.1852855450215;7362.66867990939;9686.225101991859;9973.301868869183;9984.45085520296;10293.073623373932;9956;10035.648752293671;10050.095491405773;10057.547410366551;10063.5471403787;9872.35829671069;9884.851727224097;9905.356151850106;9916.752081197956;9933.701988940344;9762.560684769202;9832.213422926148;9839;9841.606335746561;9846.310758246926;37866.24267514662;38197.23605527902;38231.23537529234;38315.616843831485;38363.80818095891;2880.8415537145447;2914.606528118698;3061.984690076558;3126.8123912565093;3344.5317655528247;27906.441871162668;28634;28666.283342916384;29020.709792902013;29838.85080574605;3492.4237500812337;3517.8065206413635;3525.3301872644115;3618.4572314152824;3640.7269454791;247818;247891.76054119793;248199;248263;248501;27950;28638.427231455255;52682.473175268526;53098;53163.734181328844;33157.83421082927;33434;33450.49824252638;33502.49746253808;33532;13363.1313964592;13422.530211442552;13454.596362109152;13462.394192261372;13464.25946572948;10112.393256404639;11206.887931120584;11223.887761122447;11268.661940141808;11294.209405341548;7555.282248186413;7830.216978302238;7927.286544211049;7957.1644977276555;7974.046358642054;3067.6932306769145;3080.614923134608;3091.27355071558;3137.3254750228352;3158.7157155856085;852.2840813716508;873.5413907698509;923.169147767015;931.1712575807537;1027.445179603006;28314.292142696184;28635.57046644302;28656.426871462452;29290.853545732134;29324;912.7124955638952;925.5025150605383;927.4481683398367;957.9042095790365;960.5917485068818;15035.774463383059;15120.941534092508;15182.620434489005;15294.082355058732;15300.770488442682;400470;405449;405851;406113;406114;48456.27315590269;49062.50937490579;49079;49232;49266;1079.7246702090918;1113.8050841102774;1177.9411029448665;1184.6446066180283;1201.678154030577;27197.184084477496;28684.85657571699;29301;29383.561303529073;29621.2594685126;42087.789561052;42122.78938605287;42594;42749.572504275806;42820.14359712726;299054;301519;301589;302634;303549;22534;22758.65862012104;22886;23345.883270584218;24917.127900523396;40726;41364.379534306405;41382.1723565533;41435.171296573295;41676.374854376605;35123.473147903314;35385;35768;35931;36199;30648;30866.868887767505;31067;31622.525662114625;32066.839665801523;34019.65980340165;35237;35252.64747352596;36126.458103127945;36527.08682282964;30801.845990769903;33182;33290.33419331552;33309;33435.498467523495;25073.749262507143;25680.229593112235;25692.486150277262;25807.225783226535;26205.868970655025 10:50:45 INFO - PROCESS | 16991 | |2;jquery.html;337.19747002134915;356.7128461588421;361.1206711657114;362.27544910179626;378.7765218521072;12792.360381980898;16202.10888401139;16206.189690515472;16645.250963706632;17659.55851103723;17081.743773843402;17305.653886922253;17490.125493725296;17597.824021759778;17662.735058974125;5001.1248031594505;5096.872578185547;5183.222516622499;5190.818321358754;5199.818006369778;3766.5291838520184;5129.461406552315;5224.138017227153;5833.8833223335505;6170.7531698732;6125.019996800513;6153.7846175383875;6190.628562286277;6191.504679625642;6194.349593292707;5944.613600116;6171.845703857394;6189.721462534197;6206.193194884681;6224.377562243762;5210.348706411699;5371.060064488738;5379.327584051994;5385.138377859563;5386.138217885159;21008.369748907404;21133.154673813027;21331.146754129815;21350.331208598924;21378.35864924055;1894.838938690213;1913.1486488512617;1935.816097470738;2132.5201829588373;2380.392999785061;8760.386772925898;9380.953095234549;12608.558700445441;13166.21002739829;13853;1547.667251540913;1652.9834701652949;1675.1959059651435;1724.7154219553759;1788.9910550447294;62325.6883715583;67648.98526522105;68131;69605.65197173982;74502.62748686277;9363.204127649089;9476.052394760469;9514.33399662031;9801.068898454636;9956.103950644478;12722.300273485047;12779.23324600527;12848.486060557472;13091.345432728516;13108.541201057917;7001.019857219993;7249.782506524813;7296.96351518239;7339.926600733925;7351.338379545759;7044.7534336299;7081.256468070881;7245.130584329809;7322.1328561217615;7322.231165727522;4010.799460026987;4075.3886916962692;4089.5092588889524;4125.381192821041;4206.684498662551;1665.1674162918541;1713.8286171382763;1726.818684038183;1728.550576850028;1734.1502663694698;364.6426502028027;366.9211119609297;389.50143815915675;625.8654389306321;898.6135961536602;10333.689989300334;10721.731956700989;10807.48695182675;10900.1279897608;15743.763843542356;807.6325272001226;821.2895845093951;837.3217693668148;863.3567991845989;871.7384784564605;8819.206271435602;9635.614575416905;9657.951710241405;9721;9989.100980911608;443081;449398;449443;452682;457043;50950.23574646383;54601.726991365584;77114.17254178952;77590.2240977583;83642.5817870919;934.0985948559672;939.722781779363;946.8295706772709;961.9326647134774;962.932594718377;14926.925365373103;15009.624759381102;15291.694166116393;15325.157116358707;15696.607584810472;36995.815020924725;37281;37316.813415932746;37845;37943.81028094842;50864.745676271385;53496;54122;54562.727186363816;55249.17126243029;6637.236717777324;6933.930660693329;7131.643417829192;7638.541687498768;7821.530708157528;10348;11428.085753139563;11699.473523691624;11863.525458981545;11937.761244775229;9596.136347728738;9610.855837162308;9938.503074846085;10141.746456338651;10214.336068155546;7908.576456237933;9370.297227707813;9742.805143897223;9989.850152247576;10271.178305735673;9676.4677942711;9720.222382209548;9783.902160978583;10110.545025473724;10161.898381016095;6433.774817881352;6468.514861385321;6476.158099447041;6495.805125846232;6504.252011018793;9592.280578956746;10020.248481364073;10200.28597998133;10305.948470257601;10447.477626118816 10:50:45 INFO - PROCESS | 16991 | |3;mootools.html;1355.518790829256;1382.4539306973745;1438.8345340285864;1612.8306527814586;1636.8194663888785;7046.894296585555;7454.440916931225;7489.812754681136;7497.587632680201;7501.399888008953;6110.083487476881;6298.275698294698;6314.1791567096325;6461;7339.816504587375;2036.1142902837314;2119.63966125759;2123.5115923337644;2133.5519540896353;2136.604728125302;2102.4428526440506;2117.91528338867;2120.766715661276;2121.7559980602273;2123.5328227789937;2040.2247146084467;2131.6056529542084;2135.1032566322183;2135.135270215565;2137.284009856692;2054.291269512031;2072.4818795301176;2076.678114892179;2078.989605051965;2080.5942841145907;2027.7870823563608;2034.3185033013958;2036.4094412620323;2042.4791678122133;2043.2542122125467;7245.130584329861;7420.109586849559;7421.25787421259;7424.628768561604;7435.256474352575;4258.425112609789;4303.483581970184;4414.249577571821;4438.178936896652;4439.533848945879;2710.6205131281636;2768.0588599876137;2821.1818572614125;2830.108515817511;2841.8579071046365;860.4149178558578;872.4922045795898;874.0778478705028;916.4959272400154;923.7782932096248;9656.565454554562;9702.757431064209;9706.951465242628;9709.883363413228;9730.562124704406;3646.690031347312;3839.3281175794123;3851.8844434666444;3999.5400528939545;4005.4792876925812;8424.410291279673;8435.789105272295;8436.114208008194;8437.198466145706;8438.36712246584;4250.404943307939;4251.978740106341;4254.404383386328;4260.701750877409;4260.723053001545;3869.496965394481;3870;3873.825677844504;3874.1476875087437;3876.127871228951;3227.757918156101;3322.252493189013;3343.9498407523906;3386.2211691311136;3397.8301084945656;974.055166488505;975.6682727872558;977.1889331854544;978.6085565773748;983.955721992512;763.0690557519818;764.0831002796666;768.6771555946516;773.7214602743009;783.6395258181301;4868.123737727172;4902.534259245366;4944.826931057396;4953.876153096129;5133.563647089964;814.9551774652332;818.2186012358184;818.3862103422433;870.912908709124;882.9669286934302;3408.9488657670154;3503.8773642922374;3514.4903988921465;3535.7524973251625;3577.5170352002147;8232;8434.15658434164;8577.914220857712;8917.955410222907;8949.418287811402;8740.21338079576;8802.603882825288;8802.779930501789;8803.603837827313;8806.075362087016;6718.731250750013;6726.529142959946;6790.8641827164165;6821.30269034957;6936.375726184567;4961.875953101201;4962.900741985068;5051.949480505295;5161.896762064663;5162.045021671003;8234.258916697527;8242.258196762321;8343.2908202801;8344.290735287568;8362.331013519026;8118.75643730689;8341.708040218564;8440.915590844259;8483;8530.658773649233;5724.79963201286;6277.466415354746;6437.25971513282;6503.577267477599;6556.508261880474;6731.798046058626;6932.168139823253;6935.861282774417;6936.895946560705;6943.51395402317;6359.20509936258;6382.32985536512;6473.061406095995;6488.091667166506;6493.22081350241;6270.811875643738;6277.780277690259;6289.371062893674;6317.557770955989;6322;5533;5581.776728930798;5588.86027849307;5601.831945041656;5616.213730077874;4095.6928230383437;4134.090500089976;4147.97926010368;4168.24971505132;4390.648748100209;4313.3961245425035;4358.716683415568;4374.387585738063;4386.40783494237;4473.194824931544 10:50:45 INFO - PROCESS | 16991 | |4;prototype.html;280.7992285515857;287.3849961083282;296.695886716116;297.476441463025;298.48362333163624;4657.6972496787685;4749.976250118753;4796.496367881375;4845.394325709286;4882.682625629336;4603.3785438965815;4743.335932969387;4746.572808447239;4750.596199323053;4760.214564596846;3773;3775.2449510097954;3776.754510956779;3785.2051069275485;3789.658930696237;3604.2431089471243;3629.6551827576336;3780.262848744496;3784.905377365574;3796.7532110412735;3751.5873253942045;3756.5492140943124;3770.5852356240794;3773.132179598694;3781.508403907502;3735.0288924879455;3741.158239396141;3745.9812700936595;3748.981255093707;3762.2287431076566;3322.401967645847;3326.268220991378;3332.3668502984356;3345.280764635615;3345.6988871001727;4498.50516443191;4648.604868586174;4674.135284972291;4694.694844835109;4697.577218050392;4298.871033868989;4305.375720520538;4310.3103503439615;4310.870673879757;4311.655067594585;5012.649114561982;5031.723255220962;5036.219385995177;5043.747812609355;5049.798008079672;3534.3991521441158;3579.8031108289033;3599.6220396858216;3649.489071529988;3656.4880916671686;5230.241614965847;5257.316548848626;5259.105951988209;5264.578833693296;5266;3666.5233519642275;3676.485292059114;3680.595134535199;3688.483612294281;3691.077230692327;3729.4965179700935;3741.8129093545213;3760.6803421708914;3770.019794853358;3778.886633401002;4187.623113919701;4227.3447615619625;4236.6187043166265;4283.693473490553;4325.4593175853015;4973.925391119136;4979.228219625964;4980.7509624518625;5006.549410553068;5021.447640759514;1237.4802582915197;1251.6808213905397;1281.2120545864227;1292.2182079841748;1301.1672529581076;846.2637505370244;878.639757699353;884.8097659003345;886.096181894464;889.5418859287472;4379.686094171736;4389.4732632083715;4401.767505098577;4413.889652758707;4416;5037.319961805109;5087.160618497906;5110.744462776921;5114.411842638145;5127.8718032048755;4364.388985542027;4365.541618130114;4375.824967001285;4394.231009573312;4407.735535867858;2288.21056735426;2421.503591763684;2426.381272775431;2427.8421902576274;2438.987805060963;4304.80628371724;4328.316443804862;4330.437043184366;4333.978330108393;4359.58043285973;4603.447586289667;4630.772845196026;4646.721196728207;4652.930206046912;4693.413323334583;4330.7401555906745;4545.340925565774;4853.878653033632;4896.433141394719;4902.3872015998;5175.844724658266;5177.767000485062;5215.973920130375;5217.9478205217465;5220.1647736362;5137.2037334213255;5142.151544995034;5142.1772516397195;5146.614003949644;5148.253503241934;4740.288956656529;4825.734584597881;4860.659753817199;4910.975445122752;4929.767558110472;3633.8546458142437;3651.068977410743;3653.6163702810823;3660.963390366169;3670.7614005089586;4981.402231732215;5159.587233021424;5161.81933632321;5164.277001219907;5187.584993200459;4884.682495637914;5025.457052777856;5042.369703787027;5051.520105589963;5064.594832413324;5054.241863720471;5061.746912654279;5073.695578265316;5079.212722028092;5092.185250360073;4834.492378300228;4946.851594452172;5006.62450316235;5032.263868965201;5051.318072060225;5066.771995260296;5075.5178258065425;5076.314697515788;5079.206436460006;5079.6698214615935;4972.538593396292;4982.900341993212;4984.277279794482;4989.55094041538;4991.625628077836 10:50:45 INFO - PROCESS | 16991 | |5;yui.html;626.5457543281119;626.6709977261934;627.1721327847241;692.9272426395229;706.4701473894578;12320.137590368679;13857;13908.582742517716;13923.930380348096;13927.303634818243;13398.12912160709;13520.188788672662;13525.053246272764;13526.729465410686;13547.119437236597;634.6382561939696;640.3948268885905;752.8945947567345;755.9999999999986;772.8492943875947;769.8806684963812;776.848514539665;781.640445395119;782.0341877780965;782.4327362662082;830.4933990265963;831.600831600832;832.9541875196862;833.0669649992018;833.6332013913889;668.7091115364783;791.1890312429806;812.4191203289677;826.3802148388709;827.0612854410258;595.5384576952853;600.6696317025662;600.8648054187817;601.011336351699;601.0893496352985;12559.497620095277;12561.811572826415;12564.371781410893;12582.18215815969;12610.369481525888;12207.511699532008;12624;12852.421641026176;13025.153365031243;13245.07284490086;11575.0161236295;11618.825717614243;11737.765244695143;11821.822672659917;12376.566820161252;4057.97971010146;4064.715469917107;4081.5306239782212;4120.21715873986;4211.599898009715;63909;64427.35572644307;64927;64971.350286497;64985;9948.80102397948;9964.551595178234;9965.40207587547;10016.14862736661;10276.332038417479;19476.123574439185;19511.60976780485;19515.609687806165;19531.804681953;19570.608587828163;6772.796816095525;6773.119494465786;6846.315368463213;6899.689513971884;6946;3704.7962362070343;3764.792936388525;3794.2601192767697;3795.962040379616;3950.822213000422;2761.0888406825698;2819.3938303264895;2840.659120905463;2847.117393607988;2852.0588205892423;498.9126902791997;499.6951859365784;502.32186548159694;507.626894232746;507.7664274433728;526.2474661234471;534.134701783106;537.819830356827;547.3076558153939;563.5632384901652;7172.605506697182;7271.563706177646;7347.595882226529;7485.962570187223;7564.9243507565325;473.3704173449304;515.2503107977883;516.7028958348965;525.4692760312113;530.973451327432;3468.739844511672;3632.664201880815;3712.7586706863967;3722.925541489155;3756.38019726742;95814;100208;103140;105453.47273263738;105850;83966.58016709877;90280;91445;92109.99999999866;93272.06727932769;74912.62543687355;76109.62794092645;76163.61918190373;77233.61383193161;77707.61146194233;6678.632675202911;6713.227978782307;6740.258571557027;6747.4264687500145;6983.6857341418745;45209.32186017147;45493.54506454893;45819.31271031004;45896;46834;39308.41037384384;47364.05271894612;53340;54389;55671.443285568246;11638.88361116378;11756.529738810694;11789.76420471603;11930.284182949052;12320.383980801103;12976.740465190833;13048.41282142287;13070.80393794113;13144;13327.933360333136;11276.210665253682;11400;11484.310941343547;11531.88468115308;11744.882551174378;10542.947285263524;11583.131265155316;11596.594119205787;11770.529178833094;12202.816957745463;11281.71795705114;11380;11890.821637675268;11910.987566056981;11939;8933.330000250136;9505.857412138685;10138.898611013796;10282.845757313497;10707.196960227859;8418.36862235347;8813.823723525365;8910;8983.101689830964;8997.100289970951 10:50:45 INFO - PROCESS | 16991 | __end_tp_report 10:50:45 INFO - PROCESS | 16991 | __start_cc_report 10:50:45 INFO - PROCESS | 16991 | _x_x_mozilla_cycle_collect,1027 10:50:45 INFO - PROCESS | 16991 | __end_cc_report 10:50:45 INFO - PROCESS | 16991 | __startTimestamp1470333045062__endTimestamp 10:50:45 INFO - PROCESS | 16991 | 10:50:45 INFO - PROCESS | 16991 | ------- Summary: start ------- 10:50:45 INFO - PROCESS | 16991 | Number of tests: 6 10:50:45 INFO - PROCESS | 16991 | 10:50:45 INFO - PROCESS | 16991 | [#0] dojo.html Cycles:165 Average:4785.08 Median:4910.98 stddev:504.52 (10.3%) stddev-sans-first:477.72 10:50:45 INFO - PROCESS | 16991 | Values: 2659.3 2663.9 2689.4 2702.3 2710.2 4645.1 4729.4 4801.3 4958.1 4963.5 4778.3 4796.2 4811.9 4816.4 4865.8 4389.8 4404.3 4477.2 4533.1 4598.7 4511.0 4545.9 4561.3 4572.0 4586.3 4328.5 4371.3 4380.4 4399.0 4483.5 4423.8 4427.3 4434.4 4437.6 4510.1 4459.8 4460.2 4476.2 4506.0 4513.1 4698.8 4742.8 4850.6 4860.6 4911.6 5138.7 5178.8 5224.2 5237.3 5237.3 5212.8 5214.7 5248.2 5249.0 5262.0 4678.2 4805.3 4860.3 4869.6 4895.6 5340.9 5362.8 5403.0 5411.9 5415.9 5133.5 5178.7 5187.7 5187.7 5192.0 5040.8 5096.3 5126.6 5224.4 5286.2 5146.3 5147.7 5151.6 5181.4 5186.2 5109.7 5110.3 5117.4 5127.7 5169.1 4313.6 4367.9 4370.0 4441.2 4500.6 3824.2 3846.3 3887.0 3934.3 3940.2 4390.4 4393.7 4396.1 4397.1 4436.4 5013.0 5057.9 5167.2 5183.9 5237.8 4336.8 4382.6 4388.3 4432.8 4453.0 4675.0 4679.9 4681.1 4688.9 4732.1 4820.3 4843.4 4868.2 4869.7 4911.0 5007.2 5130.5 5178.9 5179.9 5285.7 4885.4 4888.7 4897.1 4899.8 4931.3 5113.6 5120.1 5125.3 5126.3 5127.7 5052.8 5087.0 5116.1 5133.2 5230.1 5008.4 5010.4 5020.7 5020.8 5076.1 4987.8 5009.5 5011.9 5014.8 5037.7 4785.1 4888.9 4965.4 4968.3 5060.1 5084.5 5107.6 5112.6 5114.4 5150.3 4981.3 4984.6 4986.5 4987.0 4991.0 10:50:45 INFO - PROCESS | 16991 | 10:50:45 INFO - PROCESS | 16991 | [#1] ext.html Cycles:180 Average:45974.31 Median:18756.04 stddev:85714.13 (457.0%) stddev-sans-first:85886.74 10:50:45 INFO - PROCESS | 16991 | Values: 552.0 575.0 579.6 580.0 580.3 27625.7 30646.2 37060.4 38581.2 38789.4 39550.6 40045.4 40081.0 40093.6 40254.8 7617.6 7749.0 7754.4 7755.3 7759.2 7362.7 9686.2 9973.3 9984.5 10293.1 9956.0 10035.6 10050.1 10057.5 10063.5 9872.4 9884.9 9905.4 9916.8 9933.7 9762.6 9832.2 9839.0 9841.6 9846.3 37866.2 38197.2 38231.2 38315.6 38363.8 2880.8 2914.6 3062.0 3126.8 3344.5 27906.4 28634.0 28666.3 29020.7 29838.9 3492.4 3517.8 3525.3 3618.5 3640.7 247818.0 247891.8 248199.0 248263.0 248501.0 27950.0 28638.4 52682.5 53098.0 53163.7 33157.8 33434.0 33450.5 33502.5 33532.0 13363.1 13422.5 13454.6 13462.4 13464.3 10112.4 11206.9 11223.9 11268.7 11294.2 7555.3 7830.2 7927.3 7957.2 7974.0 3067.7 3080.6 3091.3 3137.3 3158.7 852.3 873.5 923.2 931.2 1027.4 28314.3 28635.6 28656.4 29290.9 29324.0 912.7 925.5 927.4 957.9 960.6 15035.8 15120.9 15182.6 15294.1 15300.8 400470.0 405449.0 405851.0 406113.0 406114.0 48456.3 49062.5 49079.0 49232.0 49266.0 1079.7 1113.8 1177.9 1184.6 1201.7 27197.2 28684.9 29301.0 29383.6 29621.3 42087.8 42122.8 42594.0 42749.6 42820.1 299054.0 301519.0 301589.0 302634.0 303549.0 22534.0 22758.7 22886.0 23345.9 24917.1 40726.0 41364.4 41382.2 41435.2 41676.4 35123.5 35385.0 35768.0 35931.0 36199.0 30648.0 30866.9 31067.0 31622.5 32066.8 34019.7 35237.0 35252.6 36126.5 36527.1 30801.8 33182.0 33290.3 33309.0 33435.5 25073.7 25680.2 25692.5 25807.2 26205.9 10:50:45 INFO - PROCESS | 16991 | 10:50:45 INFO - PROCESS | 16991 | [#2] jquery.html Cycles:180 Average:25641.11 Median:5156.34 stddev:73958.71 (1434.3%) stddev-sans-first:74141.78 10:50:45 INFO - PROCESS | 16991 | Values: 337.2 356.7 361.1 362.3 378.8 12792.4 16202.1 16206.2 16645.3 17659.6 17081.7 17305.7 17490.1 17597.8 17662.7 5001.1 5096.9 5183.2 5190.8 5199.8 3766.5 5129.5 5224.1 5833.9 6170.8 6125.0 6153.8 6190.6 6191.5 6194.3 5944.6 6171.8 6189.7 6206.2 6224.4 5210.3 5371.1 5379.3 5385.1 5386.1 21008.4 21133.2 21331.1 21350.3 21378.4 1894.8 1913.1 1935.8 2132.5 2380.4 8760.4 9381.0 12608.6 13166.2 13853.0 1547.7 1653.0 1675.2 1724.7 1789.0 62325.7 67649.0 68131.0 69605.7 74502.6 9363.2 9476.1 9514.3 9801.1 9956.1 12722.3 12779.2 12848.5 13091.3 13108.5 7001.0 7249.8 7297.0 7339.9 7351.3 7044.8 7081.3 7245.1 7322.1 7322.2 4010.8 4075.4 4089.5 4125.4 4206.7 1665.2 1713.8 1726.8 1728.6 1734.2 364.6 366.9 389.5 625.9 898.6 10333.7 10721.7 10807.5 10900.1 15743.8 807.6 821.3 837.3 863.4 871.7 8819.2 9635.6 9658.0 9721.0 9989.1 443081.0 449398.0 449443.0 452682.0 457043.0 50950.2 54601.7 77114.2 77590.2 83642.6 934.1 939.7 946.8 961.9 962.9 14926.9 15009.6 15291.7 15325.2 15696.6 36995.8 37281.0 37316.8 37845.0 37943.8 50864.7 53496.0 54122.0 54562.7 55249.2 6637.2 6933.9 7131.6 7638.5 7821.5 10348.0 11428.1 11699.5 11863.5 11937.8 9596.1 9610.9 9938.5 10141.7 10214.3 7908.6 9370.3 9742.8 9989.9 10271.2 9676.5 9720.2 9783.9 10110.5 10161.9 6433.8 6468.5 6476.2 6495.8 6504.3 9592.3 10020.2 10200.3 10305.9 10447.5 10:50:45 INFO - PROCESS | 16991 | 10:50:45 INFO - PROCESS | 16991 | [#3] mootools.html Cycles:180 Average:4773.75 Median:5917.44 stddev:2621.99 (44.3%) stddev-sans-first:2616.76 10:50:45 INFO - PROCESS | 16991 | Values: 1355.5 1382.5 1438.8 1612.8 1636.8 7046.9 7454.4 7489.8 7497.6 7501.4 6110.1 6298.3 6314.2 6461.0 7339.8 2036.1 2119.6 2123.5 2133.6 2136.6 2102.4 2117.9 2120.8 2121.8 2123.5 2040.2 2131.6 2135.1 2135.1 2137.3 2054.3 2072.5 2076.7 2079.0 2080.6 2027.8 2034.3 2036.4 2042.5 2043.3 7245.1 7420.1 7421.3 7424.6 7435.3 4258.4 4303.5 4414.2 4438.2 4439.5 2710.6 2768.1 2821.2 2830.1 2841.9 860.4 872.5 874.1 916.5 923.8 9656.6 9702.8 9707.0 9709.9 9730.6 3646.7 3839.3 3851.9 3999.5 4005.5 8424.4 8435.8 8436.1 8437.2 8438.4 4250.4 4252.0 4254.4 4260.7 4260.7 3869.5 3870.0 3873.8 3874.1 3876.1 3227.8 3322.3 3343.9 3386.2 3397.8 974.1 975.7 977.2 978.6 984.0 763.1 764.1 768.7 773.7 783.6 4868.1 4902.5 4944.8 4953.9 5133.6 815.0 818.2 818.4 870.9 883.0 3408.9 3503.9 3514.5 3535.8 3577.5 8232.0 8434.2 8577.9 8918.0 8949.4 8740.2 8802.6 8802.8 8803.6 8806.1 6718.7 6726.5 6790.9 6821.3 6936.4 4961.9 4962.9 5051.9 5161.9 5162.0 8234.3 8242.3 8343.3 8344.3 8362.3 8118.8 8341.7 8440.9 8483.0 8530.7 5724.8 6277.5 6437.3 6503.6 6556.5 6731.8 6932.2 6935.9 6936.9 6943.5 6359.2 6382.3 6473.1 6488.1 6493.2 6270.8 6277.8 6289.4 6317.6 6322.0 5533.0 5581.8 5588.9 5601.8 5616.2 4095.7 4134.1 4148.0 4168.2 4390.6 4313.4 4358.7 4374.4 4386.4 4473.2 10:50:45 INFO - PROCESS | 16991 | 10:50:45 INFO - PROCESS | 16991 | [#4] prototype.html Cycles:180 Average:4135.71 Median:4638.75 stddev:1204.64 (26.0%) stddev-sans-first:1172.75 10:50:45 INFO - PROCESS | 16991 | Values: 280.8 287.4 296.7 297.5 298.5 4657.7 4750.0 4796.5 4845.4 4882.7 4603.4 4743.3 4746.6 4750.6 4760.2 3773.0 3775.2 3776.8 3785.2 3789.7 3604.2 3629.7 3780.3 3784.9 3796.8 3751.6 3756.5 3770.6 3773.1 3781.5 3735.0 3741.2 3746.0 3749.0 3762.2 3322.4 3326.3 3332.4 3345.3 3345.7 4498.5 4648.6 4674.1 4694.7 4697.6 4298.9 4305.4 4310.3 4310.9 4311.7 5012.6 5031.7 5036.2 5043.7 5049.8 3534.4 3579.8 3599.6 3649.5 3656.5 5230.2 5257.3 5259.1 5264.6 5266.0 3666.5 3676.5 3680.6 3688.5 3691.1 3729.5 3741.8 3760.7 3770.0 3778.9 4187.6 4227.3 4236.6 4283.7 4325.5 4973.9 4979.2 4980.8 5006.5 5021.4 1237.5 1251.7 1281.2 1292.2 1301.2 846.3 878.6 884.8 886.1 889.5 4379.7 4389.5 4401.8 4413.9 4416.0 5037.3 5087.2 5110.7 5114.4 5127.9 4364.4 4365.5 4375.8 4394.2 4407.7 2288.2 2421.5 2426.4 2427.8 2439.0 4304.8 4328.3 4330.4 4334.0 4359.6 4603.4 4630.8 4646.7 4652.9 4693.4 4330.7 4545.3 4853.9 4896.4 4902.4 5175.8 5177.8 5216.0 5217.9 5220.2 5137.2 5142.2 5142.2 5146.6 5148.3 4740.3 4825.7 4860.7 4911.0 4929.8 3633.9 3651.1 3653.6 3661.0 3670.8 4981.4 5159.6 5161.8 5164.3 5187.6 4884.7 5025.5 5042.4 5051.5 5064.6 5054.2 5061.7 5073.7 5079.2 5092.2 4834.5 4946.9 5006.6 5032.3 5051.3 5066.8 5075.5 5076.3 5079.2 5079.7 4972.5 4982.9 4984.3 4989.6 4991.6 10:50:45 INFO - PROCESS | 16991 | 10:50:45 INFO - PROCESS | 16991 | [#5] yui.html Cycles:180 Average:17856.35 Median:23918.71 stddev:25986.67 (108.6%) stddev-sans-first:26027.37 10:50:45 INFO - PROCESS | 16991 | Values: 626.5 626.7 627.2 692.9 706.5 12320.1 13857.0 13908.6 13923.9 13927.3 13398.1 13520.2 13525.1 13526.7 13547.1 634.6 640.4 752.9 756.0 772.8 769.9 776.8 781.6 782.0 782.4 830.5 831.6 833.0 833.1 833.6 668.7 791.2 812.4 826.4 827.1 595.5 600.7 600.9 601.0 601.1 12559.5 12561.8 12564.4 12582.2 12610.4 12207.5 12624.0 12852.4 13025.2 13245.1 11575.0 11618.8 11737.8 11821.8 12376.6 4058.0 4064.7 4081.5 4120.2 4211.6 63909.0 64427.4 64927.0 64971.4 64985.0 9948.8 9964.6 9965.4 10016.1 10276.3 19476.1 19511.6 19515.6 19531.8 19570.6 6772.8 6773.1 6846.3 6899.7 6946.0 3704.8 3764.8 3794.3 3796.0 3950.8 2761.1 2819.4 2840.7 2847.1 2852.1 498.9 499.7 502.3 507.6 507.8 526.2 534.1 537.8 547.3 563.6 7172.6 7271.6 7347.6 7486.0 7564.9 473.4 515.3 516.7 525.5 531.0 3468.7 3632.7 3712.8 3722.9 3756.4 95814.0 100208.0 103140.0 105453.5 105850.0 83966.6 90280.0 91445.0 92110.0 93272.1 74912.6 76109.6 76163.6 77233.6 77707.6 6678.6 6713.2 6740.3 6747.4 6983.7 45209.3 45493.5 45819.3 45896.0 46834.0 39308.4 47364.1 53340.0 54389.0 55671.4 11638.9 11756.5 11789.8 11930.3 12320.4 12976.7 13048.4 13070.8 13144.0 13327.9 11276.2 11400.0 11484.3 11531.9 11744.9 10542.9 11583.1 11596.6 11770.5 12202.8 11281.7 11380.0 11890.8 11911.0 11939.0 8933.3 9505.9 10138.9 10282.8 10707.2 8418.4 8813.8 8910.0 8983.1 8997.1 10:50:45 INFO - PROCESS | 16991 | -------- Summary: end -------- 10:50:45 INFO - PROCESS | 16991 | 10:50:45 INFO - TEST-INFO | 16991: exit 0 10:50:45 INFO - TEST-OK | dromaeo_css | took 1119789ms 10:50:45 INFO - TEST-START | kraken 10:50:45 INFO - operating with platform_type : linux_ 10:50:45 INFO - Initialising browser for kraken test... 10:50:45 INFO - TEST-INFO | started process 17178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0mTaUK/profile http://localhost:48846/getInfo.html) 10:50:50 INFO - PROCESS | 17178 | __metrics Screen width/height:1600/1200 10:50:50 INFO - PROCESS | 17178 | colorDepth:24 10:50:50 INFO - PROCESS | 17178 | Browser inner width/height: 1024/697 10:50:50 INFO - PROCESS | 17178 | __metrics 10:50:51 INFO - PROCESS | 17178 | 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" 10:50:51 INFO - PROCESS | 17178 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:50:52 INFO - TEST-INFO | 17178: exit 0 10:50:52 INFO - Browser initialized. 10:50:52 INFO - Running cycle 1/1 for kraken test... 10:50:52 INFO - TEST-INFO | started process 17259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0mTaUK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:04 INFO - PROCESS | 17259 | RSS: Main: 156835840 10:51:04 INFO - PROCESS | 17259 | 10:51:06 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48846/tests/kraken/driver.html?testName=audio-beat-detection) 10:51:07 INFO - PROCESS | 17259 | RSS: Main: 212877312 10:51:07 INFO - PROCESS | 17259 | 10:51:10 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48846/tests/kraken/driver.html?testName=audio-dft) 10:51:11 INFO - PROCESS | 17259 | RSS: Main: 190660608 10:51:11 INFO - PROCESS | 17259 | 10:51:14 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48846/tests/kraken/driver.html?testName=audio-fft) 10:51:14 INFO - PROCESS | 17259 | RSS: Main: 269697024 10:51:14 INFO - PROCESS | 17259 | 10:51:17 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48846/tests/kraken/driver.html?testName=audio-oscillator) 10:51:17 INFO - PROCESS | 17259 | RSS: Main: 179896320 10:51:17 INFO - PROCESS | 17259 | 10:51:19 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48846/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:51:20 INFO - PROCESS | 17259 | RSS: Main: 184135680 10:51:20 INFO - PROCESS | 17259 | 10:51:23 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48846/tests/kraken/driver.html?testName=imaging-darkroom) 10:51:24 INFO - PROCESS | 17259 | RSS: Main: 220737536 10:51:24 INFO - PROCESS | 17259 | 10:51:27 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48846/tests/kraken/driver.html?testName=imaging-desaturate) 10:51:28 INFO - PROCESS | 17259 | RSS: Main: 219926528 10:51:28 INFO - PROCESS | 17259 | 10:51:31 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48846/tests/kraken/driver.html?testName=json-parse-financial) 10:51:31 INFO - PROCESS | 17259 | RSS: Main: 219185152 10:51:31 INFO - PROCESS | 17259 | 10:51:33 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48846/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:51:34 INFO - PROCESS | 17259 | RSS: Main: 183451648 10:51:34 INFO - PROCESS | 17259 | 10:51:36 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48846/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:51:36 INFO - PROCESS | 17259 | RSS: Main: 190963712 10:51:36 INFO - PROCESS | 17259 | 10:51:38 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48846/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:51:39 INFO - PROCESS | 17259 | RSS: Main: 194494464 10:51:39 INFO - PROCESS | 17259 | 10:51:42 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:51:42 INFO - PROCESS | 17259 | RSS: Main: 194613248 10:51:42 INFO - PROCESS | 17259 | 10:51:45 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:51:46 INFO - PROCESS | 17259 | RSS: Main: 194310144 10:51:46 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | Cycle 1(1): loaded http://localhost:48846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48846/tests/kraken/driver.html?testName=ai-astar) 10:51:48 INFO - PROCESS | 17259 | RSS: Main: 242905088 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | __start_tp_report 10:51:48 INFO - PROCESS | 17259 | _x_x_mozilla_page_load 10:51:48 INFO - PROCESS | 17259 | _x_x_mozilla_page_load_details 10:51:48 INFO - PROCESS | 17259 | |i|pagename|runs| 10:51:48 INFO - PROCESS | 17259 | |0;ai-astar;106;113;115;114;114;116;113;115;114;113 10:51:48 INFO - PROCESS | 17259 | |1;audio-beat-detection;148;121;123;186;121;124;151;121;172;123 10:51:48 INFO - PROCESS | 17259 | |2;audio-dft;161;161;161;161;159;160;160;162;162;161 10:51:48 INFO - PROCESS | 17259 | |3;audio-fft;75;76;77;141;76;78;76;75;112;74 10:51:48 INFO - PROCESS | 17259 | |4;audio-oscillator;86;87;111;84;85;85;118;84;85;121 10:51:48 INFO - PROCESS | 17259 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;116;117 10:51:48 INFO - PROCESS | 17259 | |6;imaging-darkroom;147;148;154;146;151;146;147;146;147;147 10:51:48 INFO - PROCESS | 17259 | |7;imaging-desaturate;95;95;95;94;95;94;95;97;95;95 10:51:48 INFO - PROCESS | 17259 | |8;json-parse-financial;64;63;63;62;62;63;62;62;64;62 10:51:48 INFO - PROCESS | 17259 | |9;json-stringify-tinderbox;64;66;66;65;65;65;65;67;65;66 10:51:48 INFO - PROCESS | 17259 | |10;stanford-crypto-aes;79;79;78;84;79;89;79;81;78;82 10:51:48 INFO - PROCESS | 17259 | |11;stanford-crypto-ccm;142;144;129;130;127;128;131;126;142;139 10:51:48 INFO - PROCESS | 17259 | |12;stanford-crypto-pbkdf2;169;166;168;167;169;171;173;170;166;167 10:51:48 INFO - PROCESS | 17259 | |13;stanford-crypto-sha256-iterative;69;67;69;72;66;68;67;67;67;66 10:51:48 INFO - PROCESS | 17259 | __end_tp_report 10:51:48 INFO - PROCESS | 17259 | __start_cc_report 10:51:48 INFO - PROCESS | 17259 | _x_x_mozilla_cycle_collect,1897 10:51:48 INFO - PROCESS | 17259 | __end_cc_report 10:51:48 INFO - PROCESS | 17259 | __startTimestamp1470333108386__endTimestamp 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | ------- Summary: start ------- 10:51:48 INFO - PROCESS | 17259 | Number of tests: 14 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.75 (2.4%) stddev-sans-first:1.05 10:51:48 INFO - PROCESS | 17259 | Values: 106.0 113.0 115.0 114.0 114.0 116.0 113.0 115.0 114.0 113.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:136.00 stddev:24.11 (17.7%) stddev-sans-first:25.35 10:51:48 INFO - PROCESS | 17259 | Values: 148.0 121.0 123.0 186.0 121.0 124.0 151.0 121.0 172.0 123.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 10:51:48 INFO - PROCESS | 17259 | Values: 161.0 161.0 161.0 161.0 159.0 160.0 160.0 162.0 162.0 161.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#3] audio-fft Cycles:10 Average:86.00 Median:76.00 stddev:22.44 (29.5%) stddev-sans-first:23.45 10:51:48 INFO - PROCESS | 17259 | Values: 75.0 76.0 77.0 141.0 76.0 78.0 76.0 75.0 112.0 74.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:85.00 stddev:15.44 (18.2%) stddev-sans-first:16.06 10:51:48 INFO - PROCESS | 17259 | Values: 86.0 87.0 111.0 84.0 85.0 85.0 118.0 84.0 85.0 121.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 10:51:48 INFO - PROCESS | 17259 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:147.00 stddev:2.60 (1.8%) stddev-sans-first:2.74 10:51:48 INFO - PROCESS | 17259 | Values: 147.0 148.0 154.0 146.0 151.0 146.0 147.0 146.0 147.0 147.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 10:51:48 INFO - PROCESS | 17259 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 97.0 95.0 95.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 10:51:48 INFO - PROCESS | 17259 | Values: 64.0 63.0 63.0 62.0 62.0 63.0 62.0 62.0 64.0 62.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 10:51:48 INFO - PROCESS | 17259 | Values: 64.0 66.0 66.0 65.0 65.0 65.0 65.0 67.0 65.0 66.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:3.46 (4.3%) stddev-sans-first:3.61 10:51:48 INFO - PROCESS | 17259 | Values: 79.0 79.0 78.0 84.0 79.0 89.0 79.0 81.0 78.0 82.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:135.00 stddev:7.08 (5.2%) stddev-sans-first:6.86 10:51:48 INFO - PROCESS | 17259 | Values: 142.0 144.0 129.0 130.0 127.0 128.0 131.0 126.0 142.0 139.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.00 stddev:2.27 (1.3%) stddev-sans-first:2.40 10:51:48 INFO - PROCESS | 17259 | Values: 169.0 166.0 168.0 167.0 169.0 171.0 173.0 170.0 166.0 167.0 10:51:48 INFO - PROCESS | 17259 | 10:51:48 INFO - PROCESS | 17259 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:1.81 (2.7%) stddev-sans-first:1.87 10:51:48 INFO - PROCESS | 17259 | Values: 69.0 67.0 69.0 72.0 66.0 68.0 67.0 67.0 67.0 66.0 10:51:48 INFO - PROCESS | 17259 | -------- Summary: end -------- 10:51:48 INFO - PROCESS | 17259 | 10:51:49 INFO - TEST-INFO | 17259: exit 0 10:51:49 INFO - TEST-OK | kraken | took 63586ms 10:51:49 INFO - SUITE-END | took 1183s 10:51:49 INFO - Completed test suite (00:19:43) 10:51:49 INFO - javascript benchmark 10:51:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.348459627391, 2663.920082397529, 2689.381442268278, 2702.297402675304, 2710.1733971138806, 4645.094206629708, 4729.408823897013, 4801.255805350168, 4958.08275469038, 4963.503649635035, 4778.259369797678, 4796.184648609736, 4811.903761924759, 4816.422029356482, 4865.756712164386, 4389.780510974447, 4404.339349097645, 4477.238869392195, 4533.093381323732, 4598.747068911225, 4510.954890451087, 4545.909081818361, 4561.315802629599, 4572.039871626962, 4586.266197408415, 4328.523862375137, 4371.34429835524, 4380.364847097153, 4398.978005109986, 4483.461984561841, 4423.845165419195, 4427.313766366218, 4434.401355816955, 4437.622802061796, 4510.052888893337, 4459.799309031101, 4460.197164510387, 4476.216662084123, 4505.977470112662, 4513.142502924434, 4698.812047518095, 4742.762861856893, 4850.6362022848425, 4860.635452341053, 4911.607071434277, 5138.7173705446185, 5178.792848286064, 5224.242484839677, 5237.266782650432, 5237.3453318335205, 5212.791488340462, 5214.713190774506, 5248.160294352885, 5248.973755131238, 5262.02652509287, 4678.157931572282, 4805.27920811874, 4860.295257187759, 4869.586085182799, 4895.6083513318845, 5340.893182136336, 5362.785488580491, 5402.972985135049, 5411.918821217685, 5415.891682166334, 5133.512316329943, 5178.741062946838, 5187.688738675692, 5187.740612969336, 5191.97404012985, 5040.7731652075745, 5096.337476128154, 5126.641135120506, 5224.373075230997, 5286.233496143038, 5146.253793199965, 5147.716875571879, 5151.6136289778415, 5181.35233095863, 5186.196139598293, 5109.693418394834, 5110.3356563646485, 5117.385913690307, 5127.692338459629, 5169.121249387613, 4313.590208930146, 4367.868963931087, 4369.978150109293, 4441.222786012435, 4500.639948804088, 3824.2351529694174, 3846.3461211593535, 3887.0, 3934.272159650474, 3940.1922605866303, 4390.407295015196, 4393.714408563433, 4396.098799746044, 4397.054633253866, 4436.423264975532, 5012.974935125301, 5057.873553161126, 5167.159653003932, 5183.870403239874, 5237.764300606482, 4336.848210312624, 4382.649388048949, 4388.319810429389, 4432.756198409118, 4452.9554704453185, 4674.953250467452, 4679.906401872012, 4681.110588988081, 4688.859334219979, 4732.077244937204, 4820.25286080658, 4843.4430040545085, 4868.172410690262, 4869.732164730974, 4910.975445122752, 5007.24891266313, 5130.51260130287, 5178.870528236825, 5179.92230116541, 5285.735713214247, 4885.364902562644, 4888.706677599355, 4897.094037603055, 4899.779509922133, 4931.3096166536, 5113.565346945403, 5120.078385890575, 5125.2568377585785, 5126.333576635014, 5127.692338459704, 5052.8484145475695, 5087.033463641897, 5116.079105760999, 5133.204353325241, 5230.084735171406, 5008.398992120969, 5010.398752149766, 5020.748962551931, 5020.849374518771, 5076.137056700296, 4987.825426110214, 5009.474005229544, 5011.9498805012945, 5014.774335154853, 5037.722925239147, 4785.066911952136, 4888.92666609994, 4965.4289756678445, 4968.27959945813, 5060.139776237975, 5084.542391184811, 5107.565856902205, 5112.590992720648, 5114.411842638145, 5150.304708864255, 4981.252812078217, 4984.6261530384645, 4986.47641997585, 4987.027529631687, 4991.026749783902], "value": 4752.682257539225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.9834404967851, 574.971251437428, 579.5653260054959, 579.9913001304981, 580.3181262017129, 27625.723742762566, 30646.241838234582, 37060.44409333862, 38581.228375432474, 38789.41815872764, 39550.60449395505, 40045.39931901017, 40081.0, 40093.59906400935, 40254.798726006404, 7617.619119044053, 7749.0, 7754.379649628045, 7755.340796032316, 7759.1852855450215, 7362.66867990939, 9686.225101991859, 9973.301868869183, 9984.45085520296, 10293.073623373932, 9956.0, 10035.648752293671, 10050.095491405773, 10057.547410366551, 10063.5471403787, 9872.35829671069, 9884.851727224097, 9905.356151850106, 9916.752081197956, 9933.701988940344, 9762.560684769202, 9832.213422926148, 9839.0, 9841.606335746561, 9846.310758246926, 37866.24267514662, 38197.23605527902, 38231.23537529234, 38315.616843831485, 38363.80818095891, 2880.8415537145447, 2914.606528118698, 3061.984690076558, 3126.8123912565093, 3344.5317655528247, 27906.441871162668, 28634.0, 28666.283342916384, 29020.709792902013, 29838.85080574605, 3492.4237500812337, 3517.8065206413635, 3525.3301872644115, 3618.4572314152824, 3640.7269454791, 247818.0, 247891.76054119793, 248199.0, 248263.0, 248501.0, 27950.0, 28638.427231455255, 52682.473175268526, 53098.0, 53163.734181328844, 33157.83421082927, 33434.0, 33450.49824252638, 33502.49746253808, 33532.0, 13363.1313964592, 13422.530211442552, 13454.596362109152, 13462.394192261372, 13464.25946572948, 10112.393256404639, 11206.887931120584, 11223.887761122447, 11268.661940141808, 11294.209405341548, 7555.282248186413, 7830.216978302238, 7927.286544211049, 7957.1644977276555, 7974.046358642054, 3067.6932306769145, 3080.614923134608, 3091.27355071558, 3137.3254750228352, 3158.7157155856085, 852.2840813716508, 873.5413907698509, 923.169147767015, 931.1712575807537, 1027.445179603006, 28314.292142696184, 28635.57046644302, 28656.426871462452, 29290.853545732134, 29324.0, 912.7124955638952, 925.5025150605383, 927.4481683398367, 957.9042095790365, 960.5917485068818, 15035.774463383059, 15120.941534092508, 15182.620434489005, 15294.082355058732, 15300.770488442682, 400470.0, 405449.0, 405851.0, 406113.0, 406114.0, 48456.27315590269, 49062.50937490579, 49079.0, 49232.0, 49266.0, 1079.7246702090918, 1113.8050841102774, 1177.9411029448665, 1184.6446066180283, 1201.678154030577, 27197.184084477496, 28684.85657571699, 29301.0, 29383.561303529073, 29621.2594685126, 42087.789561052, 42122.78938605287, 42594.0, 42749.572504275806, 42820.14359712726, 299054.0, 301519.0, 301589.0, 302634.0, 303549.0, 22534.0, 22758.65862012104, 22886.0, 23345.883270584218, 24917.127900523396, 40726.0, 41364.379534306405, 41382.1723565533, 41435.171296573295, 41676.374854376605, 35123.473147903314, 35385.0, 35768.0, 35931.0, 36199.0, 30648.0, 30866.868887767505, 31067.0, 31622.525662114625, 32066.839665801523, 34019.65980340165, 35237.0, 35252.64747352596, 36126.458103127945, 36527.08682282964, 30801.845990769903, 33182.0, 33290.33419331552, 33309.0, 33435.498467523495, 25073.749262507143, 25680.229593112235, 25692.486150277262, 25807.225783226535, 26205.868970655025], "value": 16632.578779896005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.19747002134915, 356.7128461588421, 361.1206711657114, 362.27544910179626, 378.7765218521072, 12792.360381980898, 16202.10888401139, 16206.189690515472, 16645.250963706632, 17659.55851103723, 17081.743773843402, 17305.653886922253, 17490.125493725296, 17597.824021759778, 17662.735058974125, 5001.1248031594505, 5096.872578185547, 5183.222516622499, 5190.818321358754, 5199.818006369778, 3766.5291838520184, 5129.461406552315, 5224.138017227153, 5833.8833223335505, 6170.7531698732, 6125.019996800513, 6153.7846175383875, 6190.628562286277, 6191.504679625642, 6194.349593292707, 5944.613600116, 6171.845703857394, 6189.721462534197, 6206.193194884681, 6224.377562243762, 5210.348706411699, 5371.060064488738, 5379.327584051994, 5385.138377859563, 5386.138217885159, 21008.369748907404, 21133.154673813027, 21331.146754129815, 21350.331208598924, 21378.35864924055, 1894.838938690213, 1913.1486488512617, 1935.816097470738, 2132.5201829588373, 2380.392999785061, 8760.386772925898, 9380.953095234549, 12608.558700445441, 13166.21002739829, 13853.0, 1547.667251540913, 1652.9834701652949, 1675.1959059651435, 1724.7154219553759, 1788.9910550447294, 62325.6883715583, 67648.98526522105, 68131.0, 69605.65197173982, 74502.62748686277, 9363.204127649089, 9476.052394760469, 9514.33399662031, 9801.068898454636, 9956.103950644478, 12722.300273485047, 12779.23324600527, 12848.486060557472, 13091.345432728516, 13108.541201057917, 7001.019857219993, 7249.782506524813, 7296.96351518239, 7339.926600733925, 7351.338379545759, 7044.7534336299, 7081.256468070881, 7245.130584329809, 7322.1328561217615, 7322.231165727522, 4010.799460026987, 4075.3886916962692, 4089.5092588889524, 4125.381192821041, 4206.684498662551, 1665.1674162918541, 1713.8286171382763, 1726.818684038183, 1728.550576850028, 1734.1502663694698, 364.6426502028027, 366.9211119609297, 389.50143815915675, 625.8654389306321, 898.6135961536602, 10333.689989300334, 10721.731956700989, 10807.48695182675, 10900.1279897608, 15743.763843542356, 807.6325272001226, 821.2895845093951, 837.3217693668148, 863.3567991845989, 871.7384784564605, 8819.206271435602, 9635.614575416905, 9657.951710241405, 9721.0, 9989.100980911608, 443081.0, 449398.0, 449443.0, 452682.0, 457043.0, 50950.23574646383, 54601.726991365584, 77114.17254178952, 77590.2240977583, 83642.5817870919, 934.0985948559672, 939.722781779363, 946.8295706772709, 961.9326647134774, 962.932594718377, 14926.925365373103, 15009.624759381102, 15291.694166116393, 15325.157116358707, 15696.607584810472, 36995.815020924725, 37281.0, 37316.813415932746, 37845.0, 37943.81028094842, 50864.745676271385, 53496.0, 54122.0, 54562.727186363816, 55249.17126243029, 6637.236717777324, 6933.930660693329, 7131.643417829192, 7638.541687498768, 7821.530708157528, 10348.0, 11428.085753139563, 11699.473523691624, 11863.525458981545, 11937.761244775229, 9596.136347728738, 9610.855837162308, 9938.503074846085, 10141.746456338651, 10214.336068155546, 7908.576456237933, 9370.297227707813, 9742.805143897223, 9989.850152247576, 10271.178305735673, 9676.4677942711, 9720.222382209548, 9783.902160978583, 10110.545025473724, 10161.898381016095, 6433.774817881352, 6468.514861385321, 6476.158099447041, 6495.805125846232, 6504.252011018793, 9592.280578956746, 10020.248481364073, 10200.28597998133, 10305.948470257601, 10447.477626118816], "value": 7999.6289834029685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.518790829256, 1382.4539306973745, 1438.8345340285864, 1612.8306527814586, 1636.8194663888785, 7046.894296585555, 7454.440916931225, 7489.812754681136, 7497.587632680201, 7501.399888008953, 6110.083487476881, 6298.275698294698, 6314.1791567096325, 6461.0, 7339.816504587375, 2036.1142902837314, 2119.63966125759, 2123.5115923337644, 2133.5519540896353, 2136.604728125302, 2102.4428526440506, 2117.91528338867, 2120.766715661276, 2121.7559980602273, 2123.5328227789937, 2040.2247146084467, 2131.6056529542084, 2135.1032566322183, 2135.135270215565, 2137.284009856692, 2054.291269512031, 2072.4818795301176, 2076.678114892179, 2078.989605051965, 2080.5942841145907, 2027.7870823563608, 2034.3185033013958, 2036.4094412620323, 2042.4791678122133, 2043.2542122125467, 7245.130584329861, 7420.109586849559, 7421.25787421259, 7424.628768561604, 7435.256474352575, 4258.425112609789, 4303.483581970184, 4414.249577571821, 4438.178936896652, 4439.533848945879, 2710.6205131281636, 2768.0588599876137, 2821.1818572614125, 2830.108515817511, 2841.8579071046365, 860.4149178558578, 872.4922045795898, 874.0778478705028, 916.4959272400154, 923.7782932096248, 9656.565454554562, 9702.757431064209, 9706.951465242628, 9709.883363413228, 9730.562124704406, 3646.690031347312, 3839.3281175794123, 3851.8844434666444, 3999.5400528939545, 4005.4792876925812, 8424.410291279673, 8435.789105272295, 8436.114208008194, 8437.198466145706, 8438.36712246584, 4250.404943307939, 4251.978740106341, 4254.404383386328, 4260.701750877409, 4260.723053001545, 3869.496965394481, 3870.0, 3873.825677844504, 3874.1476875087437, 3876.127871228951, 3227.757918156101, 3322.252493189013, 3343.9498407523906, 3386.2211691311136, 3397.8301084945656, 974.055166488505, 975.6682727872558, 977.1889331854544, 978.6085565773748, 983.955721992512, 763.0690557519818, 764.0831002796666, 768.6771555946516, 773.7214602743009, 783.6395258181301, 4868.123737727172, 4902.534259245366, 4944.826931057396, 4953.876153096129, 5133.563647089964, 814.9551774652332, 818.2186012358184, 818.3862103422433, 870.912908709124, 882.9669286934302, 3408.9488657670154, 3503.8773642922374, 3514.4903988921465, 3535.7524973251625, 3577.5170352002147, 8232.0, 8434.15658434164, 8577.914220857712, 8917.955410222907, 8949.418287811402, 8740.21338079576, 8802.603882825288, 8802.779930501789, 8803.603837827313, 8806.075362087016, 6718.731250750013, 6726.529142959946, 6790.8641827164165, 6821.30269034957, 6936.375726184567, 4961.875953101201, 4962.900741985068, 5051.949480505295, 5161.896762064663, 5162.045021671003, 8234.258916697527, 8242.258196762321, 8343.2908202801, 8344.290735287568, 8362.331013519026, 8118.75643730689, 8341.708040218564, 8440.915590844259, 8483.0, 8530.658773649233, 5724.79963201286, 6277.466415354746, 6437.25971513282, 6503.577267477599, 6556.508261880474, 6731.798046058626, 6932.168139823253, 6935.861282774417, 6936.895946560705, 6943.51395402317, 6359.20509936258, 6382.32985536512, 6473.061406095995, 6488.091667166506, 6493.22081350241, 6270.811875643738, 6277.780277690259, 6289.371062893674, 6317.557770955989, 6322.0, 5533.0, 5581.776728930798, 5588.86027849307, 5601.831945041656, 5616.213730077874, 4095.6928230383437, 4134.090500089976, 4147.97926010368, 4168.24971505132, 4390.648748100209, 4313.3961245425035, 4358.716683415568, 4374.387585738063, 4386.40783494237, 4473.194824931544], "value": 3870.5024410169935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.7992285515857, 287.3849961083282, 296.695886716116, 297.476441463025, 298.48362333163624, 4657.6972496787685, 4749.976250118753, 4796.496367881375, 4845.394325709286, 4882.682625629336, 4603.3785438965815, 4743.335932969387, 4746.572808447239, 4750.596199323053, 4760.214564596846, 3773.0, 3775.2449510097954, 3776.754510956779, 3785.2051069275485, 3789.658930696237, 3604.2431089471243, 3629.6551827576336, 3780.262848744496, 3784.905377365574, 3796.7532110412735, 3751.5873253942045, 3756.5492140943124, 3770.5852356240794, 3773.132179598694, 3781.508403907502, 3735.0288924879455, 3741.158239396141, 3745.9812700936595, 3748.981255093707, 3762.2287431076566, 3322.401967645847, 3326.268220991378, 3332.3668502984356, 3345.280764635615, 3345.6988871001727, 4498.50516443191, 4648.604868586174, 4674.135284972291, 4694.694844835109, 4697.577218050392, 4298.871033868989, 4305.375720520538, 4310.3103503439615, 4310.870673879757, 4311.655067594585, 5012.649114561982, 5031.723255220962, 5036.219385995177, 5043.747812609355, 5049.798008079672, 3534.3991521441158, 3579.8031108289033, 3599.6220396858216, 3649.489071529988, 3656.4880916671686, 5230.241614965847, 5257.316548848626, 5259.105951988209, 5264.578833693296, 5266.0, 3666.5233519642275, 3676.485292059114, 3680.595134535199, 3688.483612294281, 3691.077230692327, 3729.4965179700935, 3741.8129093545213, 3760.6803421708914, 3770.019794853358, 3778.886633401002, 4187.623113919701, 4227.3447615619625, 4236.6187043166265, 4283.693473490553, 4325.4593175853015, 4973.925391119136, 4979.228219625964, 4980.7509624518625, 5006.549410553068, 5021.447640759514, 1237.4802582915197, 1251.6808213905397, 1281.2120545864227, 1292.2182079841748, 1301.1672529581076, 846.2637505370244, 878.639757699353, 884.8097659003345, 886.096181894464, 889.5418859287472, 4379.686094171736, 4389.4732632083715, 4401.767505098577, 4413.889652758707, 4416.0, 5037.319961805109, 5087.160618497906, 5110.744462776921, 5114.411842638145, 5127.8718032048755, 4364.388985542027, 4365.541618130114, 4375.824967001285, 4394.231009573312, 4407.735535867858, 2288.21056735426, 2421.503591763684, 2426.381272775431, 2427.8421902576274, 2438.987805060963, 4304.80628371724, 4328.316443804862, 4330.437043184366, 4333.978330108393, 4359.58043285973, 4603.447586289667, 4630.772845196026, 4646.721196728207, 4652.930206046912, 4693.413323334583, 4330.7401555906745, 4545.340925565774, 4853.878653033632, 4896.433141394719, 4902.3872015998, 5175.844724658266, 5177.767000485062, 5215.973920130375, 5217.9478205217465, 5220.1647736362, 5137.2037334213255, 5142.151544995034, 5142.1772516397195, 5146.614003949644, 5148.253503241934, 4740.288956656529, 4825.734584597881, 4860.659753817199, 4910.975445122752, 4929.767558110472, 3633.8546458142437, 3651.068977410743, 3653.6163702810823, 3660.963390366169, 3670.7614005089586, 4981.402231732215, 5159.587233021424, 5161.81933632321, 5164.277001219907, 5187.584993200459, 4884.682495637914, 5025.457052777856, 5042.369703787027, 5051.520105589963, 5064.594832413324, 5054.241863720471, 5061.746912654279, 5073.695578265316, 5079.212722028092, 5092.185250360073, 4834.492378300228, 4946.851594452172, 5006.62450316235, 5032.263868965201, 5051.318072060225, 5066.771995260296, 5075.5178258065425, 5076.314697515788, 5079.206436460006, 5079.6698214615935, 4972.538593396292, 4982.900341993212, 4984.277279794482, 4989.55094041538, 4991.625628077836], "value": 3753.0588360734664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.5457543281119, 626.6709977261934, 627.1721327847241, 692.9272426395229, 706.4701473894578, 12320.137590368679, 13857.0, 13908.582742517716, 13923.930380348096, 13927.303634818243, 13398.12912160709, 13520.188788672662, 13525.053246272764, 13526.729465410686, 13547.119437236597, 634.6382561939696, 640.3948268885905, 752.8945947567345, 755.9999999999986, 772.8492943875947, 769.8806684963812, 776.848514539665, 781.640445395119, 782.0341877780965, 782.4327362662082, 830.4933990265963, 831.600831600832, 832.9541875196862, 833.0669649992018, 833.6332013913889, 668.7091115364783, 791.1890312429806, 812.4191203289677, 826.3802148388709, 827.0612854410258, 595.5384576952853, 600.6696317025662, 600.8648054187817, 601.011336351699, 601.0893496352985, 12559.497620095277, 12561.811572826415, 12564.371781410893, 12582.18215815969, 12610.369481525888, 12207.511699532008, 12624.0, 12852.421641026176, 13025.153365031243, 13245.07284490086, 11575.0161236295, 11618.825717614243, 11737.765244695143, 11821.822672659917, 12376.566820161252, 4057.97971010146, 4064.715469917107, 4081.5306239782212, 4120.21715873986, 4211.599898009715, 63909.0, 64427.35572644307, 64927.0, 64971.350286497, 64985.0, 9948.80102397948, 9964.551595178234, 9965.40207587547, 10016.14862736661, 10276.332038417479, 19476.123574439185, 19511.60976780485, 19515.609687806165, 19531.804681953, 19570.608587828163, 6772.796816095525, 6773.119494465786, 6846.315368463213, 6899.689513971884, 6946.0, 3704.7962362070343, 3764.792936388525, 3794.2601192767697, 3795.962040379616, 3950.822213000422, 2761.0888406825698, 2819.3938303264895, 2840.659120905463, 2847.117393607988, 2852.0588205892423, 498.9126902791997, 499.6951859365784, 502.32186548159694, 507.626894232746, 507.7664274433728, 526.2474661234471, 534.134701783106, 537.819830356827, 547.3076558153939, 563.5632384901652, 7172.605506697182, 7271.563706177646, 7347.595882226529, 7485.962570187223, 7564.9243507565325, 473.3704173449304, 515.2503107977883, 516.7028958348965, 525.4692760312113, 530.973451327432, 3468.739844511672, 3632.664201880815, 3712.7586706863967, 3722.925541489155, 3756.38019726742, 95814.0, 100208.0, 103140.0, 105453.47273263738, 105850.0, 83966.58016709877, 90280.0, 91445.0, 92109.99999999866, 93272.06727932769, 74912.62543687355, 76109.62794092645, 76163.61918190373, 77233.61383193161, 77707.61146194233, 6678.632675202911, 6713.227978782307, 6740.258571557027, 6747.4264687500145, 6983.6857341418745, 45209.32186017147, 45493.54506454893, 45819.31271031004, 45896.0, 46834.0, 39308.41037384384, 47364.05271894612, 53340.0, 54389.0, 55671.443285568246, 11638.88361116378, 11756.529738810694, 11789.76420471603, 11930.284182949052, 12320.383980801103, 12976.740465190833, 13048.41282142287, 13070.80393794113, 13144.0, 13327.933360333136, 11276.210665253682, 11400.0, 11484.310941343547, 11531.88468115308, 11744.882551174378, 10542.947285263524, 11583.131265155316, 11596.594119205787, 11770.529178833094, 12202.816957745463, 11281.71795705114, 11380.0, 11890.821637675268, 11910.987566056981, 11939.0, 8933.330000250136, 9505.857412138685, 10138.898611013796, 10282.845757313497, 10707.196960227859, 8418.36862235347, 8813.823723525365, 8910.0, 8983.101689830964, 8997.100289970951], "value": 6482.640621113665, "unit": "score"}], "name": "dromaeo_css", "value": 6249.142529013728, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 115.0, 114.0, 114.0, 116.0, 113.0, 115.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 123.0, 186.0, 121.0, 124.0, 151.0, 121.0, 172.0, 123.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 159.0, 160.0, 160.0, 162.0, 162.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 141.0, 76.0, 78.0, 76.0, 75.0, 112.0, 74.0], "value": 86.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 111.0, 84.0, 85.0, 85.0, 118.0, 84.0, 85.0, 121.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 154.0, 146.0, 151.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 97.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 64.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 84.0, 79.0, 89.0, 79.0, 81.0, 78.0, 82.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 144.0, 129.0, 130.0, 127.0, 128.0, 131.0, 126.0, 142.0, 139.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 168.0, 167.0, 169.0, 171.0, 173.0, 170.0, 166.0, 167.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 72.0, 66.0, 68.0, 67.0, 67.0, 67.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1532.3999999999999, "alertThreshold": 2.0}]} 10:51:49 INFO - Return code: 0 10:51:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:51:49 INFO - # TBPL SUCCESS # 10:51:49 INFO - Running post-action listener: _resource_record_post_action 10:51:49 INFO - [mozharness: 2016-08-04 17:51:49.694600Z] Finished run-tests step (success) 10:51:49 INFO - Running post-run listener: _resource_record_post_run 10:51:49 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534138880; Read time: 16; Write time: 465388 10:51:49 INFO - TinderboxPrint: CPU usage
13.0% 10:51:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:51:49 INFO - TinderboxPrint: I/O write bytes / time
534,138,880 / 465,388 10:51:49 INFO - TinderboxPrint: CPU idle
8,333.1 (87.0%) 10:51:49 INFO - TinderboxPrint: CPU user
1,199.8 (12.5%) 10:51:49 INFO - TinderboxPrint: Swap in / out
0 / 0 10:51:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246501376; Read time: 0; Write time: 251660 10:51:49 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 283197440; Read time: 0; Write time: 213292 10:51:50 INFO - Running post-run listener: _upload_blobber_files 10:51:50 INFO - Blob upload gear active. 10:51:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:51:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:51:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:51 INFO - (blobuploader) - INFO - Done attempting. 10:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:51:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:55 INFO - (blobuploader) - INFO - Done attempting. 10:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:56 INFO - (blobuploader) - INFO - Done attempting. 10:51:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:51:56 INFO - Return code: 0 10:51:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:51:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:51:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2667f81f0eb38fbec4b2644aef074fb14ce56b43259bf5f66fd8190f0fff1643b50c835dee7038e25fab34018cb355820dda17fdc5284a257c347c0599f61a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/557176884aabd9a01f3ecfc489045740607fe8c13047f5603a21088aa9fe37be62029f487271eadc46a16e5e75c502701c3b9fcc715957243bc57a7e134ea3bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f659cf57200bdc2b88237da797c21d476559dfca6b9d209996eca82de091f09e89336acb9ca4dcd7a30c1cbcdf922515049f6fa949cc9b25ea41272742a6a58"} 10:51:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:51:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:51:56 INFO - Contents: 10:51:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2667f81f0eb38fbec4b2644aef074fb14ce56b43259bf5f66fd8190f0fff1643b50c835dee7038e25fab34018cb355820dda17fdc5284a257c347c0599f61a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/557176884aabd9a01f3ecfc489045740607fe8c13047f5603a21088aa9fe37be62029f487271eadc46a16e5e75c502701c3b9fcc715957243bc57a7e134ea3bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f659cf57200bdc2b88237da797c21d476559dfca6b9d209996eca82de091f09e89336acb9ca4dcd7a30c1cbcdf922515049f6fa949cc9b25ea41272742a6a58"} 10:51:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:51:56 INFO - Copying logs to upload dir... 10:51:56 INFO - mkdir: /builds/slave/test/build/upload/logs 10:51:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.284702 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-04 10:51:56.024664) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 10:51:56.028424) ========= 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=4300f881736b422476174874000001bc-1470329670.398845-855975246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2667f81f0eb38fbec4b2644aef074fb14ce56b43259bf5f66fd8190f0fff1643b50c835dee7038e25fab34018cb355820dda17fdc5284a257c347c0599f61a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/557176884aabd9a01f3ecfc489045740607fe8c13047f5603a21088aa9fe37be62029f487271eadc46a16e5e75c502701c3b9fcc715957243bc57a7e134ea3bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f659cf57200bdc2b88237da797c21d476559dfca6b9d209996eca82de091f09e89336acb9ca4dcd7a30c1cbcdf922515049f6fa949cc9b25ea41272742a6a58"} build_url:https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011506 build_url: 'https://queue.taskcluster.net/v1/task/LJ4On6mATku02XIHSqvtCQ/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/Fx-Team-Non-PGO/sha512/2667f81f0eb38fbec4b2644aef074fb14ce56b43259bf5f66fd8190f0fff1643b50c835dee7038e25fab34018cb355820dda17fdc5284a257c347c0599f61a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/557176884aabd9a01f3ecfc489045740607fe8c13047f5603a21088aa9fe37be62029f487271eadc46a16e5e75c502701c3b9fcc715957243bc57a7e134ea3bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f659cf57200bdc2b88237da797c21d476559dfca6b9d209996eca82de091f09e89336acb9ca4dcd7a30c1cbcdf922515049f6fa949cc9b25ea41272742a6a58"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 10:51:56.054934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:51:56.055280) ========= 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=4300f881736b422476174874000001bc-1470329670.398845-855975246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:51:56.139524) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 10:51:56.139840) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 10:51:56.140159) ========= ========= Total master_lag: 0.18 =========