builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1472504732.0 results: success (0) buildid: 20160829133031 builduid: 5cf13757889f43dd95c46aa607b25e69 revision: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:31.996306) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:31.996846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:31.997179) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.013103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.013543) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 14:05:32-- 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% 39.4M=0s 2016-08-29 14:05:32 (39.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126446 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.154126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.154438) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014939 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.204050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.204449) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 --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 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 --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=7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 14:05:32,299 truncating revision to first 12 chars 2016-08-29 14:05:32,299 Setting DEBUG logging. 2016-08-29 14:05:32,299 attempt 1/10 2016-08-29 14:05:32,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/578a16bf30e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 14:05:32,595 unpacking tar archive at: fx-team-578a16bf30e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660007 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.878403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.878780) ========= script_repo_revision: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.879346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.879616) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 14:05:32.890412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-29 14:05:32.890835) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:05:33 INFO - MultiFileLogger online at 20160829 14:05:33 in /builds/slave/test 14:05:33 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 14:05:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:05:33 INFO - {'append_to_log': False, 14:05:33 INFO - 'base_work_dir': '/builds/slave/test', 14:05:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:05:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:05:33 INFO - 'branch': 'Fx-Team-Non-PGO', 14:05:33 INFO - 'buildbot_json_path': 'buildprops.json', 14:05:33 INFO - 'config_files': ('talos/linux_config.py',), 14:05:33 INFO - 'default_actions': ('clobber', 14:05:33 INFO - 'read-buildbot-config', 14:05:33 INFO - 'download-and-extract', 14:05:33 INFO - 'populate-webroot', 14:05:33 INFO - 'create-virtualenv', 14:05:33 INFO - 'install', 14:05:33 INFO - 'run-tests'), 14:05:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:05:33 INFO - 'download_minidump_stackwalk': True, 14:05:33 INFO - 'download_symbols': 'ondemand', 14:05:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:05:33 INFO - 'tooltool.py': '/tools/tooltool.py', 14:05:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:05:33 INFO - '/tools/misc-python/virtualenv.py')}, 14:05:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:05:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:05:33 INFO - 'installer_path': 'installer.exe', 14:05:33 INFO - 'log_level': 'info', 14:05:33 INFO - 'log_name': 'talos', 14:05:33 INFO - 'log_to_console': True, 14:05:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:05:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:05:33 INFO - 'opt_config_files': (), 14:05:33 INFO - 'pip_index': False, 14:05:33 INFO - 'sps_profile': False, 14:05:33 INFO - 'sps_profile_interval': 0, 14:05:33 INFO - 'suite': 'dromaeojs', 14:05:33 INFO - 'system_bits': '32', 14:05:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:05:33 INFO - 'title': 'talos-linux64-ix-005', 14:05:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:05:33 INFO - 'use_talos_json': True, 14:05:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:05:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:05:33 INFO - 'work_dir': 'build'} 14:05:33 INFO - [mozharness: 2016-08-29 21:05:33.077562Z] Running clobber step. 14:05:33 INFO - Running pre-action listener: _resource_record_pre_action 14:05:33 INFO - Running main action method: clobber 14:05:33 INFO - rmtree: /builds/slave/test/build 14:05:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:05:33 INFO - Running post-action listener: _resource_record_post_action 14:05:33 INFO - [mozharness: 2016-08-29 21:05:33.565124Z] Finished clobber step (success) 14:05:33 INFO - [mozharness: 2016-08-29 21:05:33.565227Z] Running read-buildbot-config step. 14:05:33 INFO - Running pre-action listener: _resource_record_pre_action 14:05:33 INFO - Running main action method: read_buildbot_config 14:05:33 INFO - Using buildbot properties: 14:05:33 INFO - { 14:05:33 INFO - "project": "", 14:05:33 INFO - "product": "firefox", 14:05:33 INFO - "script_repo_revision": "production", 14:05:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:05:33 INFO - "repository": "", 14:05:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:05:33 INFO - "buildid": "20160829133031", 14:05:33 INFO - "pgo_build": "False", 14:05:33 INFO - "basedir": "/builds/slave/test", 14:05:33 INFO - "buildnumber": 1899, 14:05:33 INFO - "slavename": "talos-linux64-ix-005", 14:05:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:05:33 INFO - "platform": "ubuntu64_hw", 14:05:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:05:33 INFO - "branch": "fx-team", 14:05:33 INFO - "repo_path": "integration/fx-team", 14:05:33 INFO - "revision": "578a16bf30e47ceb2aba7c5fd53b7eaba9829610", 14:05:33 INFO - "stage_platform": "linux64", 14:05:33 INFO - "builduid": "5cf13757889f43dd95c46aa607b25e69", 14:05:33 INFO - "slavebuilddir": "test" 14:05:33 INFO - } 14:05:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:05:33 INFO - Running post-action listener: _resource_record_post_action 14:05:33 INFO - [mozharness: 2016-08-29 21:05:33.567678Z] Finished read-buildbot-config step (success) 14:05:33 INFO - [mozharness: 2016-08-29 21:05:33.567769Z] Running download-and-extract step. 14:05:33 INFO - Running pre-action listener: _resource_record_pre_action 14:05:33 INFO - Running main action method: download_and_extract 14:05:33 INFO - mkdir: /builds/slave/test/build/tests 14:05: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')]} 14:05:33 INFO - trying https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:05:33 INFO - Downloading https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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 14:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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 14:05:34 INFO - Downloaded 1361 bytes. 14:05:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:05:34 INFO - Using the following test package requirements: 14:05:34 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:05:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:05:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:05:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'jsshell-linux-x86_64.zip'], 14:05:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:05:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:05:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:05:34 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:05:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:05:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:05:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:34 INFO - trying https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:05:34 INFO - Downloading https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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 14:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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 14:05:34 INFO - Downloaded 20305552 bytes. 14:05:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 14:05:39 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 14:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:39 INFO - trying https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:05:39 INFO - Downloading https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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 14:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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 14:05:40 INFO - Downloaded 20305552 bytes. 14:05:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 14:05:44 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')]} 14:05:44 INFO - trying https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:05:44 INFO - Downloading https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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 14:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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 14:05:45 INFO - Downloaded 14413998 bytes. 14:05:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 14:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:46 INFO - trying https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:05:46 INFO - Downloading https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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 14:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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 14:05:47 INFO - Downloaded 55868593 bytes. 14:05:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:05:47 INFO - mkdir: /builds/slave/test/properties 14:05:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:05:47 INFO - Writing to file /builds/slave/test/properties/build_url 14:05:47 INFO - Contents: 14:05:47 INFO - build_url:https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:05:48 INFO - Running post-action listener: _resource_record_post_action 14:05:48 INFO - Running post-action listener: set_extra_try_arguments 14:05:48 INFO - [mozharness: 2016-08-29 21:05:48.329282Z] Finished download-and-extract step (success) 14:05:48 INFO - [mozharness: 2016-08-29 21:05:48.329514Z] Running populate-webroot step. 14:05:48 INFO - Running pre-action listener: _resource_record_pre_action 14:05:48 INFO - Running main action method: populate_webroot 14:05:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:05:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:05:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:05:48 INFO - '--tppagecycles', 14:05:48 INFO - '7'], 14:05:48 INFO - 'tests': ['tsvgm']}}, 14:05:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:05:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:05:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:05:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:05:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:48 INFO - 'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:48 INFO - 'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['damp', 'tps']}, 14:05:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:48 INFO - 'tests': ['damp', 'tps']}, 14:05:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['dromaeo_dom']}, 14:05:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:05:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['basic_compositor_video']}, 14:05:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:05:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['a11yr', 14:05:48 INFO - 'ts_paint', 14:05:48 INFO - 'tpaint', 14:05:48 INFO - 'sessionrestore', 14:05:48 INFO - 'sessionrestore_no_auto_restore', 14:05:48 INFO - 'tabpaint']}, 14:05:48 INFO - 'other-e10s': {'tests': ['a11yr', 14:05:48 INFO - 'ts_paint', 14:05:48 INFO - 'tpaint', 14:05:48 INFO - 'sessionrestore', 14:05:48 INFO - 'sessionrestore_no_auto_restore', 14:05:48 INFO - 'tabpaint']}, 14:05:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:05:48 INFO - 'ts_paint', 14:05:48 INFO - 'tpaint', 14:05:48 INFO - 'sessionrestore', 14:05:48 INFO - 'sessionrestore_no_auto_restore', 14:05:48 INFO - 'tabpaint']}, 14:05:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:05:48 INFO - 'ts_paint', 14:05:48 INFO - 'tpaint', 14:05:48 INFO - 'sessionrestore', 14:05:48 INFO - 'sessionrestore_no_auto_restore', 14:05:48 INFO - 'tabpaint']}, 14:05:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['a11yr', 14:05:48 INFO - 'ts_paint', 14:05:48 INFO - 'tpaint', 14:05:48 INFO - 'sessionrestore', 14:05:48 INFO - 'sessionrestore_no_auto_restore', 14:05:48 INFO - 'tabpaint']}, 14:05:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['a11yr', 14:05:48 INFO - 'ts_paint', 14:05:48 INFO - 'tpaint', 14:05:48 INFO - 'sessionrestore', 14:05:48 INFO - 'sessionrestore_no_auto_restore', 14:05:48 INFO - 'tabpaint']}, 14:05:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['tsvgx', 14:05:48 INFO - 'tsvgr_opacity', 14:05:48 INFO - 'tart', 14:05:48 INFO - 'tscrollx', 14:05:48 INFO - 'cart']}, 14:05:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:05:48 INFO - 'tsvgr_opacity', 14:05:48 INFO - 'tart', 14:05:48 INFO - 'tscrollx', 14:05:48 INFO - 'cart']}, 14:05:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:48 INFO - 'talos_options': ['--disable-e10s'], 14:05:48 INFO - 'tests': ['tp5o']}, 14:05:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:48 INFO - 'tests': ['tp5o']}, 14:05:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:48 INFO - 'talos_options': ['--disable-e10s', 14:05:48 INFO - '--xperf_path', 14:05:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:48 INFO - 'tests': ['tp5n']}, 14:05:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:48 INFO - 'talos_options': ['--xperf_path', 14:05:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:48 INFO - 'tests': ['tp5n']}}, 14:05:48 INFO - 'talos.zip': {'path': '', 14:05:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:05:48 INFO - Running post-action listener: _resource_record_post_action 14:05:48 INFO - [mozharness: 2016-08-29 21:05:48.350133Z] Finished populate-webroot step (success) 14:05:48 INFO - [mozharness: 2016-08-29 21:05:48.350223Z] Running create-virtualenv step. 14:05:48 INFO - Running pre-action listener: _resource_record_pre_action 14:05:48 INFO - Running main action method: create_virtualenv 14:05:48 INFO - Creating virtualenv /builds/slave/test/build/venv 14:05:48 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 14:05:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:05:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:05:48 INFO - Using real prefix '/usr' 14:05:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:05:48 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:50 INFO - Installing pip.................done. 14:05:50 INFO - Return code: 0 14:05:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:50 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 0x7f1a67f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', '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 14:05:50 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 14:05:50 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 14:05:50 INFO - Using env: {'DISPLAY': ':0', 14:05:50 INFO - 'HOME': '/home/cltbld', 14:05:50 INFO - 'LANG': 'en_US.UTF-8', 14:05:50 INFO - 'LANGUAGE': 'en_US:en', 14:05:50 INFO - 'LOGNAME': 'cltbld', 14:05:50 INFO - 'MAIL': '/var/mail/cltbld', 14:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:50 INFO - 'MOZ_NO_REMOTE': '1', 14:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:50 INFO - 'NO_EM_RESTART': '1', 14:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:50 INFO - 'PWD': '/builds/slave/test', 14:05:50 INFO - 'SHELL': '/bin/bash', 14:05:50 INFO - 'SHLVL': '1', 14:05:50 INFO - 'TERM': 'linux', 14:05:50 INFO - 'TMOUT': '86400', 14:05:50 INFO - 'USER': 'cltbld', 14:05:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:50 INFO - '_': '/tools/buildbot/bin/python'} 14:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:51 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 14:05:51 INFO - Cleaning up... 14:05:51 INFO - Return code: 0 14:05:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1a67f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', '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 14:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:05:51 INFO - Using env: {'DISPLAY': ':0', 14:05:51 INFO - 'HOME': '/home/cltbld', 14:05:51 INFO - 'LANG': 'en_US.UTF-8', 14:05:51 INFO - 'LANGUAGE': 'en_US:en', 14:05:51 INFO - 'LOGNAME': 'cltbld', 14:05:51 INFO - 'MAIL': '/var/mail/cltbld', 14:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:51 INFO - 'MOZ_NO_REMOTE': '1', 14:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:51 INFO - 'NO_EM_RESTART': '1', 14:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:51 INFO - 'PWD': '/builds/slave/test', 14:05:51 INFO - 'SHELL': '/bin/bash', 14:05:51 INFO - 'SHLVL': '1', 14:05:51 INFO - 'TERM': 'linux', 14:05:51 INFO - 'TMOUT': '86400', 14:05:51 INFO - 'USER': 'cltbld', 14:05:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:51 INFO - '_': '/tools/buildbot/bin/python'} 14:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:51 INFO - Downloading/unpacking psutil>=3.1.1 14:05:51 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 14:05:51 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 14:05:51 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 14:05:51 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 14:05:51 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 14:05:51 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 14:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:53 INFO - Installing collected packages: psutil 14:05:53 INFO - Running setup.py install for psutil 14:05:53 INFO - building 'psutil._psutil_linux' extension 14:05:53 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 14:05:53 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 14:05:53 INFO - building 'psutil._psutil_posix' extension 14:05:53 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 14:05:53 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 14:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:53 INFO - Successfully installed psutil 14:05:53 INFO - Cleaning up... 14:05:53 INFO - Return code: 0 14:05:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a67f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', '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 14:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:05:53 INFO - Using env: {'DISPLAY': ':0', 14:05:53 INFO - 'HOME': '/home/cltbld', 14:05:53 INFO - 'LANG': 'en_US.UTF-8', 14:05:53 INFO - 'LANGUAGE': 'en_US:en', 14:05:53 INFO - 'LOGNAME': 'cltbld', 14:05:53 INFO - 'MAIL': '/var/mail/cltbld', 14:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:53 INFO - 'MOZ_NO_REMOTE': '1', 14:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:53 INFO - 'NO_EM_RESTART': '1', 14:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:53 INFO - 'PWD': '/builds/slave/test', 14:05:53 INFO - 'SHELL': '/bin/bash', 14:05:53 INFO - 'SHLVL': '1', 14:05:53 INFO - 'TERM': 'linux', 14:05:53 INFO - 'TMOUT': '86400', 14:05:53 INFO - 'USER': 'cltbld', 14:05:53 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:53 INFO - '_': '/tools/buildbot/bin/python'} 14:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:05:55 INFO - Installing collected packages: mozsystemmonitor 14:05:55 INFO - Running setup.py install for mozsystemmonitor 14:05:56 INFO - Successfully installed mozsystemmonitor 14:05:56 INFO - Cleaning up... 14:05:56 INFO - Return code: 0 14:05:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:05:56 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')]} 14:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:56 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')]} 14:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:56 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 0x7f1a67f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', '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 14:05:56 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 14:05:56 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 14:05:56 INFO - Using env: {'DISPLAY': ':0', 14:05:56 INFO - 'HOME': '/home/cltbld', 14:05:56 INFO - 'LANG': 'en_US.UTF-8', 14:05:56 INFO - 'LANGUAGE': 'en_US:en', 14:05:56 INFO - 'LOGNAME': 'cltbld', 14:05:56 INFO - 'MAIL': '/var/mail/cltbld', 14:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:56 INFO - 'MOZ_NO_REMOTE': '1', 14:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:56 INFO - 'NO_EM_RESTART': '1', 14:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:56 INFO - 'PWD': '/builds/slave/test', 14:05:56 INFO - 'SHELL': '/bin/bash', 14:05:56 INFO - 'SHLVL': '1', 14:05:56 INFO - 'TERM': 'linux', 14:05:56 INFO - 'TMOUT': '86400', 14:05:56 INFO - 'USER': 'cltbld', 14:05:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:56 INFO - '_': '/tools/buildbot/bin/python'} 14:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:56 INFO - Downloading/unpacking jsonschema==2.5.1 14:05:56 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 14:05:56 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 14:05:56 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 14:05:56 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 14:05:56 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 14:05:56 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 14:05:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:05:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:05:58 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 14:05:58 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 14:05:58 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 14:05:58 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 14:05:58 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 14:05:58 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 14:05:58 INFO - Downloading functools32-3.2.3-2.tar.gz 14:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:05:58 INFO - warning: no files found matching '*.txt' 14:05:58 INFO - no previously-included directories found matching 'build' 14:05:58 INFO - no previously-included directories found matching 'dist' 14:05:58 INFO - no previously-included directories found matching '.git*' 14:05:58 INFO - Installing collected packages: jsonschema, functools32 14:05:58 INFO - Running setup.py install for functools32 14:05:58 INFO - warning: no files found matching '*.txt' 14:05:58 INFO - no previously-included directories found matching 'build' 14:05:58 INFO - no previously-included directories found matching 'dist' 14:05:58 INFO - no previously-included directories found matching '.git*' 14:05:58 INFO - Successfully installed jsonschema functools32 14:05:58 INFO - Cleaning up... 14:05:58 INFO - Return code: 0 14:05:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:58 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 0x7f1a67f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', '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 14:05:58 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 14:05:58 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 14:05:58 INFO - Using env: {'DISPLAY': ':0', 14:05:58 INFO - 'HOME': '/home/cltbld', 14:05:58 INFO - 'LANG': 'en_US.UTF-8', 14:05:58 INFO - 'LANGUAGE': 'en_US:en', 14:05:58 INFO - 'LOGNAME': 'cltbld', 14:05:58 INFO - 'MAIL': '/var/mail/cltbld', 14:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:58 INFO - 'MOZ_NO_REMOTE': '1', 14:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:58 INFO - 'NO_EM_RESTART': '1', 14:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:58 INFO - 'PWD': '/builds/slave/test', 14:05:58 INFO - 'SHELL': '/bin/bash', 14:05:58 INFO - 'SHLVL': '1', 14:05:58 INFO - 'TERM': 'linux', 14:05:58 INFO - 'TMOUT': '86400', 14:05:58 INFO - 'USER': 'cltbld', 14:05:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:58 INFO - '_': '/tools/buildbot/bin/python'} 14:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:05:58 INFO - Cleaning up... 14:05:58 INFO - Return code: 0 14:05:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:58 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 0x7f1a67f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', '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 14:05:58 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 14:05:58 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 14:05:58 INFO - Using env: {'DISPLAY': ':0', 14:05:58 INFO - 'HOME': '/home/cltbld', 14:05:58 INFO - 'LANG': 'en_US.UTF-8', 14:05:58 INFO - 'LANGUAGE': 'en_US:en', 14:05:58 INFO - 'LOGNAME': 'cltbld', 14:05:58 INFO - 'MAIL': '/var/mail/cltbld', 14:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:58 INFO - 'MOZ_NO_REMOTE': '1', 14:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:58 INFO - 'NO_EM_RESTART': '1', 14:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:58 INFO - 'PWD': '/builds/slave/test', 14:05:58 INFO - 'SHELL': '/bin/bash', 14:05:58 INFO - 'SHLVL': '1', 14:05:58 INFO - 'TERM': 'linux', 14:05:58 INFO - 'TMOUT': '86400', 14:05:58 INFO - 'USER': 'cltbld', 14:05:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:58 INFO - '_': '/tools/buildbot/bin/python'} 14:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:59 INFO - Downloading/unpacking blobuploader==1.2.4 14:05:59 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 14:05:59 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 14:05:59 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 14:05:59 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 14:05:59 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 14:05:59 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 14:06:01 INFO - Downloading blobuploader-1.2.4.tar.gz 14:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:06:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:06:01 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 14:06:01 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 14:06:01 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 14:06:01 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 14:06:01 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 14:06:01 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 14:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:06:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:06:01 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 14:06:01 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 14:06:01 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 14:06:01 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 14:06:01 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 14:06:01 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 14:06:01 INFO - Downloading docopt-0.6.1.tar.gz 14:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:06:01 INFO - Installing collected packages: blobuploader, requests, docopt 14:06:01 INFO - Running setup.py install for blobuploader 14:06:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:06:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:06:01 INFO - Running setup.py install for requests 14:06:02 INFO - Running setup.py install for docopt 14:06:02 INFO - Successfully installed blobuploader requests docopt 14:06:02 INFO - Cleaning up... 14:06:02 INFO - Return code: 0 14:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:02 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 0x7f1a67f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', '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 14:06:02 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 14:06:02 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 14:06:02 INFO - Using env: {'DISPLAY': ':0', 14:06:02 INFO - 'HOME': '/home/cltbld', 14:06:02 INFO - 'LANG': 'en_US.UTF-8', 14:06:02 INFO - 'LANGUAGE': 'en_US:en', 14:06:02 INFO - 'LOGNAME': 'cltbld', 14:06:02 INFO - 'MAIL': '/var/mail/cltbld', 14:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:02 INFO - 'MOZ_NO_REMOTE': '1', 14:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:02 INFO - 'NO_EM_RESTART': '1', 14:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:02 INFO - 'PWD': '/builds/slave/test', 14:06:02 INFO - 'SHELL': '/bin/bash', 14:06:02 INFO - 'SHLVL': '1', 14:06:02 INFO - 'TERM': 'linux', 14:06:02 INFO - 'TMOUT': '86400', 14:06:02 INFO - 'USER': 'cltbld', 14:06:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:02 INFO - '_': '/tools/buildbot/bin/python'} 14:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:02 INFO - Running setup.py (path:/tmp/pip-JstMR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:02 INFO - Running setup.py (path:/tmp/pip-Eb0nXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:02 INFO - Running setup.py (path:/tmp/pip-hXYFcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:02 INFO - Running setup.py (path:/tmp/pip-ZzTqnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:02 INFO - Running setup.py (path:/tmp/pip-toamgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:02 INFO - Running setup.py (path:/tmp/pip-LaNH4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:03 INFO - Running setup.py (path:/tmp/pip-6gDzrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:03 INFO - Running setup.py (path:/tmp/pip-tSYymq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:03 INFO - Running setup.py (path:/tmp/pip-v8Dt79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:03 INFO - Running setup.py (path:/tmp/pip-tRxKoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:03 INFO - Running setup.py (path:/tmp/pip-bh7XkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:03 INFO - Running setup.py (path:/tmp/pip-La394f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:03 INFO - Running setup.py (path:/tmp/pip-hIa2aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:03 INFO - Running setup.py (path:/tmp/pip-dXgkNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:03 INFO - Running setup.py (path:/tmp/pip-DuuTwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:03 INFO - Running setup.py (path:/tmp/pip-DBLzN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:03 INFO - Running setup.py (path:/tmp/pip-FF78c1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:06:03 INFO - Running setup.py install for manifestparser 14:06:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:06:03 INFO - Running setup.py install for mozcrash 14:06:04 INFO - Running setup.py install for mozdebug 14:06:04 INFO - Running setup.py install for mozdevice 14:06:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:06:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:06:04 INFO - Running setup.py install for mozfile 14:06:04 INFO - Running setup.py install for mozhttpd 14:06:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:06:04 INFO - Running setup.py install for mozinfo 14:06:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:06:04 INFO - Running setup.py install for mozInstall 14:06:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:06:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:06:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:06:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:06:04 INFO - Running setup.py install for mozleak 14:06:04 INFO - Running setup.py install for mozlog 14:06:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:06:04 INFO - Running setup.py install for moznetwork 14:06:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:06:04 INFO - Running setup.py install for mozprocess 14:06:05 INFO - Running setup.py install for mozprofile 14:06:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:06:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:06:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:06:05 INFO - Running setup.py install for mozrunner 14:06:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:06:05 INFO - Running setup.py install for mozscreenshot 14:06:05 INFO - Running setup.py install for moztest 14:06:05 INFO - Running setup.py install for mozversion 14:06:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:06:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:06:05 INFO - Cleaning up... 14:06:05 INFO - Return code: 0 14:06:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06: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')]} 14:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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')]} 14:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:05 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 0x7f1a67f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', '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 14:06:05 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 14:06:05 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 14:06:05 INFO - Using env: {'DISPLAY': ':0', 14:06:05 INFO - 'HOME': '/home/cltbld', 14:06:05 INFO - 'LANG': 'en_US.UTF-8', 14:06:05 INFO - 'LANGUAGE': 'en_US:en', 14:06:05 INFO - 'LOGNAME': 'cltbld', 14:06:05 INFO - 'MAIL': '/var/mail/cltbld', 14:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:05 INFO - 'MOZ_NO_REMOTE': '1', 14:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:05 INFO - 'NO_EM_RESTART': '1', 14:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:05 INFO - 'PWD': '/builds/slave/test', 14:06:05 INFO - 'SHELL': '/bin/bash', 14:06:05 INFO - 'SHLVL': '1', 14:06:05 INFO - 'TERM': 'linux', 14:06:05 INFO - 'TMOUT': '86400', 14:06:05 INFO - 'USER': 'cltbld', 14:06:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:05 INFO - '_': '/tools/buildbot/bin/python'} 14:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:05 INFO - Running setup.py (path:/tmp/pip-j3wzV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:05 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)) 14:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:05 INFO - Running setup.py (path:/tmp/pip-deprmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:05 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)) 14:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:05 INFO - Running setup.py (path:/tmp/pip-m8TofU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:06 INFO - Running setup.py (path:/tmp/pip-KRv1uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:06 INFO - Running setup.py (path:/tmp/pip-TMFDht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:06 INFO - Running setup.py (path:/tmp/pip-R64rQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:06 INFO - Running setup.py (path:/tmp/pip-nBEDE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:06 INFO - Running setup.py (path:/tmp/pip-G1BsLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:06 INFO - Running setup.py (path:/tmp/pip-W2HQDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:06 INFO - Running setup.py (path:/tmp/pip-2nPn_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:06 INFO - Running setup.py (path:/tmp/pip-I5VIEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:06 INFO - Running setup.py (path:/tmp/pip-o_ugXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:06 INFO - Running setup.py (path:/tmp/pip-HCdMgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:06 INFO - Running setup.py (path:/tmp/pip-DQ9cSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:06 INFO - Running setup.py (path:/tmp/pip-nde3pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:06 INFO - Running setup.py (path:/tmp/pip-fnw4un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:06 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)) 14:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:06 INFO - Running setup.py (path:/tmp/pip-uN14XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:07 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)) 14:06:07 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)) 14:06:07 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)) 14:06:07 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)) 14:06:07 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)) 14:06:07 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)) 14:06:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:08 INFO - Downloading blessings-1.6.tar.gz 14:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:06:09 INFO - Installing collected packages: blessings 14:06:09 INFO - Running setup.py install for blessings 14:06:09 INFO - Successfully installed blessings 14:06:09 INFO - Cleaning up... 14:06:09 INFO - Return code: 0 14:06:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:09 INFO - Reading from file tmpfile_stdout 14:06:09 INFO - Current package versions: 14:06:09 INFO - argparse == 1.2.1 14:06:09 INFO - blessings == 1.6 14:06:09 INFO - blobuploader == 1.2.4 14:06:09 INFO - docopt == 0.6.1 14:06:09 INFO - functools32 == 3.2.3-2 14:06:09 INFO - jsonschema == 2.5.1 14:06:09 INFO - manifestparser == 1.1 14:06:09 INFO - mozInstall == 1.12 14:06:09 INFO - mozcrash == 0.17 14:06:09 INFO - mozdebug == 0.1 14:06:09 INFO - mozdevice == 0.48 14:06:09 INFO - mozfile == 1.2 14:06:09 INFO - mozhttpd == 0.7 14:06:09 INFO - mozinfo == 0.9 14:06:09 INFO - mozleak == 0.1 14:06:09 INFO - mozlog == 3.3 14:06:09 INFO - moznetwork == 0.27 14:06:09 INFO - mozprocess == 0.23 14:06:09 INFO - mozprofile == 0.28 14:06:09 INFO - mozrunner == 6.12 14:06:09 INFO - mozscreenshot == 0.1 14:06:09 INFO - mozsystemmonitor == 0.3 14:06:09 INFO - moztest == 0.7 14:06:09 INFO - mozversion == 1.4 14:06:09 INFO - psutil == 3.1.1 14:06:09 INFO - requests == 1.2.3 14:06:09 INFO - wsgiref == 0.1.2 14:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:09 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')]} 14:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:09 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')]} 14:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:09 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 0x7f1a67f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', '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 14:06:09 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 14:06:09 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 14:06:09 INFO - Using env: {'DISPLAY': ':0', 14:06:09 INFO - 'HOME': '/home/cltbld', 14:06:09 INFO - 'LANG': 'en_US.UTF-8', 14:06:09 INFO - 'LANGUAGE': 'en_US:en', 14:06:09 INFO - 'LOGNAME': 'cltbld', 14:06:09 INFO - 'MAIL': '/var/mail/cltbld', 14:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:09 INFO - 'MOZ_NO_REMOTE': '1', 14:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:09 INFO - 'NO_EM_RESTART': '1', 14:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:09 INFO - 'PWD': '/builds/slave/test', 14:06:09 INFO - 'SHELL': '/bin/bash', 14:06:09 INFO - 'SHLVL': '1', 14:06:09 INFO - 'TERM': 'linux', 14:06:09 INFO - 'TMOUT': '86400', 14:06:09 INFO - 'USER': 'cltbld', 14:06:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:09 INFO - '_': '/tools/buildbot/bin/python'} 14:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:09 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)) 14:06:09 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)) 14:06:09 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)) 14:06:09 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)) 14:06:09 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)) 14:06:09 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)) 14:06:09 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)) 14:06:09 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)) 14:06:09 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)) 14:06:09 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)) 14:06:09 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)) 14:06:09 INFO - Cleaning up... 14:06:09 INFO - Return code: 0 14:06:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:06:09 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')]} 14:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:09 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')]} 14:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:09 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 0x7f1a67f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', '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 14:06:09 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 14:06:09 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 14:06:09 INFO - Using env: {'DISPLAY': ':0', 14:06:09 INFO - 'HOME': '/home/cltbld', 14:06:09 INFO - 'LANG': 'en_US.UTF-8', 14:06:09 INFO - 'LANGUAGE': 'en_US:en', 14:06:09 INFO - 'LOGNAME': 'cltbld', 14:06:09 INFO - 'MAIL': '/var/mail/cltbld', 14:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:09 INFO - 'MOZ_NO_REMOTE': '1', 14:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:09 INFO - 'NO_EM_RESTART': '1', 14:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:09 INFO - 'PWD': '/builds/slave/test', 14:06:09 INFO - 'SHELL': '/bin/bash', 14:06:09 INFO - 'SHLVL': '1', 14:06:09 INFO - 'TERM': 'linux', 14:06:09 INFO - 'TMOUT': '86400', 14:06:09 INFO - 'USER': 'cltbld', 14:06:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:09 INFO - '_': '/tools/buildbot/bin/python'} 14:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:06:09 INFO - Cleaning up... 14:06:09 INFO - Return code: 0 14:06:09 INFO - Running post-action listener: _resource_record_post_action 14:06:09 INFO - Running post-action listener: _start_resource_monitoring 14:06:09 INFO - Starting resource monitoring. 14:06:09 INFO - [mozharness: 2016-08-29 21:06:09.862200Z] Finished create-virtualenv step (success) 14:06:09 INFO - [mozharness: 2016-08-29 21:06:09.862668Z] Running install step. 14:06:09 INFO - Running pre-action listener: _resource_record_pre_action 14:06:09 INFO - Running main action method: install 14:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:10 INFO - Reading from file tmpfile_stdout 14:06:10 INFO - Detecting whether we're running mozinstall >=1.0... 14:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:06:10 INFO - Reading from file tmpfile_stdout 14:06:10 INFO - Output received: 14:06:10 INFO - Usage: mozinstall [options] installer 14:06:10 INFO - Options: 14:06:10 INFO - -h, --help show this help message and exit 14:06:10 INFO - -d DEST, --destination=DEST 14:06:10 INFO - Directory to install application into. [default: 14:06:10 INFO - "/builds/slave/test"] 14:06:10 INFO - --app=APP Application being installed. [default: firefox] 14:06:10 INFO - mkdir: /builds/slave/test/build/application 14:06:10 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'] 14:06:10 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 14:06:26 INFO - Reading from file tmpfile_stdout 14:06:26 INFO - Output received: 14:06:26 INFO - /builds/slave/test/build/application/firefox/firefox 14:06:26 INFO - Running post-action listener: _resource_record_post_action 14:06:26 INFO - [mozharness: 2016-08-29 21:06:26.694323Z] Finished install step (success) 14:06:26 INFO - [mozharness: 2016-08-29 21:06:26.694607Z] Running run-tests step. 14:06:26 INFO - Running pre-action listener: _resource_record_pre_action 14:06:26 INFO - Running main action method: run_tests 14:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:06:26 INFO - Python 2.7.3 14:06:26 INFO - Return code: 0 14:06:26 INFO - grabbing minidump binary from tooltool 14:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:26 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 0x1fc4d20>, '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 0x1fc5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc60b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:06:26 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 14:06:26 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 14:06:26 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 14:06:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:06:26 INFO - Return code: 0 14:06:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:06:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:06:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:06:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:06:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:06:26 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/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 14:06:26 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/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 14:06:26 INFO - Using env: {'DISPLAY': ':0', 14:06:26 INFO - 'HOME': '/home/cltbld', 14:06:26 INFO - 'LANG': 'en_US.UTF-8', 14:06:26 INFO - 'LANGUAGE': 'en_US:en', 14:06:26 INFO - 'LOGNAME': 'cltbld', 14:06:26 INFO - 'MAIL': '/var/mail/cltbld', 14:06:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:06:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:26 INFO - 'MOZ_NO_REMOTE': '1', 14:06:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:26 INFO - 'NO_EM_RESTART': '1', 14:06:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:26 INFO - 'PWD': '/builds/slave/test', 14:06:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:06:26 INFO - 'SHELL': '/bin/bash', 14:06:26 INFO - 'SHLVL': '1', 14:06:26 INFO - 'TERM': 'linux', 14:06:26 INFO - 'TMOUT': '86400', 14:06:26 INFO - 'USER': 'cltbld', 14:06:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182', 14:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:26 INFO - '_': '/tools/buildbot/bin/python'} 14:06:26 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/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 14:06:26 INFO - mozversion application_buildid: 20160829133031 14:06:26 INFO - mozversion application_changeset: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 14:06:26 INFO - mozversion application_display_name: Nightly 14:06:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:06:26 INFO - mozversion application_name: Firefox 14:06:26 INFO - mozversion application_remotingname: firefox 14:06:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:06:26 INFO - mozversion application_vendor: Mozilla 14:06:26 INFO - mozversion application_version: 51.0a1 14:06:26 INFO - mozversion platform_buildid: 20160829133031 14:06:26 INFO - mozversion platform_changeset: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 14:06:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:06:26 INFO - mozversion platform_version: 51.0a1 14:06:26 INFO - using testdate: 1472504786 14:06:26 INFO - actual date: 1472504786 14:06:26 INFO - starting webserver on 'localhost:40866' 14:06:26 INFO - SUITE-START | Running 2 tests 14:06:26 INFO - TEST-START | dromaeo_css 14:06:26 INFO - operating with platform_type : linux_ 14:06:26 INFO - Initialising browser for dromaeo_css test... 14:06:26 INFO - TEST-INFO | started process 10785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdHQiEr/profile http://localhost:40866/getInfo.html) 14:06:31 INFO - PROCESS | 10785 | __metrics Screen width/height:1600/1200 14:06:31 INFO - PROCESS | 10785 | colorDepth:24 14:06:31 INFO - PROCESS | 10785 | Browser inner width/height: 1024/697 14:06:31 INFO - PROCESS | 10785 | __metrics 14:06:32 INFO - PROCESS | 10785 | 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" 14:06:32 INFO - PROCESS | 10785 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:32 INFO - PROCESS | 10785 | console.error: PushService: 14:06:32 INFO - PROCESS | 10785 | stateChangeProcessEnqueue: Error transitioning state 14:06:32 INFO - PROCESS | 10785 | UnknownError 14:06:33 INFO - TEST-INFO | 10785: exit 0 14:06:33 INFO - Browser initialized. 14:06:33 INFO - Running cycle 1/1 for dromaeo_css test... 14:06:33 INFO - TEST-INFO | started process 10864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdHQiEr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:45 INFO - PROCESS | 10864 | RSS: Main: 182505472 14:06:45 INFO - PROCESS | 10864 | 14:07:36 INFO - PROCESS | 10864 | 1472504856700 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] 14:09:49 INFO - PROCESS | 10864 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40866/tests/dromaeo/cssquery-ext.html) 14:09:50 INFO - PROCESS | 10864 | RSS: Main: 294436864 14:09:50 INFO - PROCESS | 10864 | 14:12:53 INFO - PROCESS | 10864 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-ext.html (next: http://localhost:40866/tests/dromaeo/cssquery-jquery.html) 14:12:54 INFO - PROCESS | 10864 | RSS: Main: 269430784 14:12:54 INFO - PROCESS | 10864 | 14:15:56 INFO - PROCESS | 10864 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40866/tests/dromaeo/cssquery-mootools.html) 14:15:57 INFO - PROCESS | 10864 | RSS: Main: 218562560 14:15:57 INFO - PROCESS | 10864 | 14:18:59 INFO - PROCESS | 10864 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40866/tests/dromaeo/cssquery-prototype.html) 14:18:59 INFO - PROCESS | 10864 | RSS: Main: 217931776 14:18:59 INFO - PROCESS | 10864 | 14:22:03 INFO - PROCESS | 10864 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40866/tests/dromaeo/cssquery-yui.html) 14:22:03 INFO - PROCESS | 10864 | RSS: Main: 219860992 14:22:03 INFO - PROCESS | 10864 | 14:25:06 INFO - PROCESS | 10864 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-yui.html (next: http://localhost:40866/tests/dromaeo/cssquery-dojo.html) 14:25:06 INFO - PROCESS | 10864 | RSS: Main: 313065472 14:25:06 INFO - PROCESS | 10864 | 14:25:06 INFO - PROCESS | 10864 | __start_tp_report 14:25:06 INFO - PROCESS | 10864 | _x_x_mozilla_page_load 14:25:06 INFO - PROCESS | 10864 | _x_x_mozilla_page_load_details 14:25:06 INFO - PROCESS | 10864 | |i|pagename|runs| 14:25:06 INFO - PROCESS | 10864 | |0;dojo.html;2574.009006532485;2579.5356835769553;2597.5194589001035;2605.426806102658;2615.4246065865514;4530.501644819067;4560.270356742922;4610.077984403116;4645.721256724599;4699.694519856207;4609.516000819907;4651.5348465153465;4672.5327467253255;4683.4379874415035;4685.2269375553;4244.278472659647;4311.202427550913;4316.82732690692;4375.496817865938;4386.824527018932;4291.4421125253675;4298.914021719564;4301.591348821857;4408.735475871442;4432.3794668746405;4331.523532411448;4350.54319296474;4404.69167158299;4442.600165985061;4444.17782710198;4367.890802729926;4398.34024896265;4429.844955426561;4448.666350023761;4457.732536047847;4218.1985422769885;4235.597618226264;4259.318509038539;4307.892302692458;4311.6335111515555;4588.334691469719;4602.1946159422305;4602.941323495615;4618.468876079227;4704.905901881977;4964.081644895669;4983.72589507577;4997.075541024922;5008.62435317349;5067.746612669352;4892.192788189945;4943.728094954776;5010.774515146827;5018.272350509193;5089.134847076006;4662.067586482717;4681.789319480631;4681.859544213611;4689.062187562501;4690.413698287714;5129.051125541787;5138.4604616514725;5168.431472538018;5190.039842629126;5220.060389129993;4817.349657796222;4826.420829500412;4916.237983112624;4931.432885218174;4933.309336692866;4938.604911607063;4965.155923493015;4967.05625931072;5005.399352077701;5020.895403011332;4896.436909755353;4907.460179380265;4908.435529914105;4925.901481970341;4976.900461990812;4791.520847915181;4852.8301509447;4896.094222568836;4912.459629440758;4956.851294461172;4200.5169405518145;4235.576442355739;4241.851535196253;4245.23585754561;4278.422412974271;3681.742278040565;3683.594804571495;3697.6302369762807;3718.1448266898765;3724.944125838115;4251.574842515785;4309.978450107729;4314.115606300764;4315.050688848449;4359.760213188241;4987;5010.724410157403;5033.018561380496;5087.567556757643;5097.974510127426;4352.499462561846;4354.238008348526;4358.36803663467;4379.956200438019;4407.118576284756;4552.681312308173;4559.6124329431705;4564.132814765184;4567.63458923292;4620.5379462053525;4594.081183763194;4717.764111794465;4757.26262429324;4761.428628564595;4767.547083027107;5043.798248070036;5046.747662616928;5047.671901326549;5053.26727624485;5087.771050302671;4739.478657347758;4768.976155119202;4777.3311736356245;4777.570018698334;4818.494058123846;4801.639877009308;4881.267809828412;4917.459079501181;4931.457539670705;5025.246213068069;4986.8753281168265;5007.223880298559;5007.7496125192865;5011.173156429149;5055.014272216882;4846.297286893451;4847.515248475124;4847.61219102478;4848.32123502717;4930.161872481615;4769.022350418225;4826.469088400203;4849.563539281482;4870.853874383774;4932.45742968266;4793.304970779148;4800.567948884477;4809.975950120367;4858.198397264412;4883.121038213156;4911.656184067081;4914.311996320589;4915.680480768739;4918.827841025547;4977.651564390458;4701.318308845267;4750.8337208197545;4757.476677565396;4790.832320868893;4810.831620893252 14:25:06 INFO - PROCESS | 10864 | |1;ext.html;559.9216109744636;574.7183879898851;584.2842517915553;587.3949831673375;588.3792598808255;26978.190654280355;36669.44995825065;37975.86072417828;38101.428478572845;42058.15883682332;39643.801780991125;40389.79805100978;40533.189336213334;40533.338666053416;40538;7664.540127592349;7810.258025487569;7814.960925195366;7816.648250828698;7818.921810781876;7564.773056808304;7629.313361797437;7640.847183056336;7641.4268929830205;7643.732469363574;7466.626668666572;7493.850122997536;7506.249375062477;7506.62466876654;7511.211322811108;7619.695212191506;7636.885446718304;7647;7650.043744531906;7653.196414376466;7652.655630496641;7657.731979380695;7720.459567830254;7725.806854828618;7728.536287822749;37303.813480932695;37536.43695344572;37698.43452348217;37707.434388484195;37719.24561508782;2914.8688309026143;2935.809172403808;3050.9847450762604;3467.1678797088516;3595.694365978895;27431.86284068567;28023.73893174812;28427.57358639622;28695;28809.135725928256;3365.2764655599162;3425.5889293284963;3444.6383129771266;3454.8790792322397;3493.074335301147;272553;277636;278286;377096;379069;48757.26864097041;49008.264876026886;49034.50965490299;49184;49209.26186107211;28479.43041139207;29227.707722922925;29439.558406623917;44516.55483445124;44849.32726009112;13508.392122354519;13700.314984250748;13750.312484375741;13763.862361376257;13764.17414955106;10377.481125943672;10482.056614904543;10509.632162874263;10516.68449946503;10532.315399499008;17461;17586.648267034587;17613.207405666777;17643.20605572752;17723.73414398785;6769.458443324522;6788.355106264897;6843.657817109125;6853.485988550879;6949.44404447643;773.7756050745334;841.448851002582;889.7775556110972;932.2215949681956;953.4898829126384;24129.638055429183;24726.381840454134;25121.874390628294;25168.119115830857;25246.621300680505;792.4769652029632;898.9101089890959;909.7225346269319;940.416941496263;1005.100435110572;12905.612831615066;13497.190168589916;13736.65658358529;13897.79153312701;14048.26058918501;378048;381428;382084;382361;383234;46881;47402.76298618485;47417.76291118591;47428.288575671395;47429.76285118552;1043.1133536494071;1108.6563165418584;1131.8472006279046;1151.1308961733837;1166.445938179358;24616.753832462164;27290.86354568294;27903.581446277916;28384.57423138696;28940.855295723388;33055.83472082624;33399.16502087467;33448.66551334455;33452.832735836164;33489;277066;278733;279805;279968;280702;24392;25191.74808251894;25222.99108035658;26132.216033519024;26184.476310473303;35128.29743405169;35826.462603061496;36248.81875590605;36293.63706362902;38482.0379490515;34581.30837383188;34589.308213836084;34676.65323346835;34867;34963.65036349604;34125.48811767875;34129.48805767965;34275.31449371049;34578.82710586431;34668.306633866676;34408;34850.47724284087;34980;35110.47334290039;35772.64227357693;29943.251418714706;32100.678993209767;32346.353072937938;32383.676163238066;32555.511667324536;24271.271861844172;24597.754022460264;24972.75136243217;25066.498670026864;25399 14:25:06 INFO - PROCESS | 10864 | |2;jquery.html;330.7106282003247;349.97375196860236;350.32911973570606;352.8324046078113;369.30201918374263;12370.13409061365;15469.767953480692;16271.755923661154;16317.02097874127;17530.298788048494;15958.521244362688;16205;16232.188390580453;16479.176041197952;16643.41748038819;4926.876828079291;5061.266116413118;5173;5174.456682048387;5174.715390653512;5737.168110623957;5907.88184236315;5924.259467566554;5932.466078052975;5938.732757025922;5808.5023439920815;5857.531397488191;5898.439648233432;5907.084401917709;5929.762809487615;5871.089981052944;5882.117682347639;5898.8230353089475;5904.0553511437965;5905.970470147665;4955.380577427822;5106.234064890259;5146.794128234867;5171.069207542679;5181.792728290864;20752.896235518878;20853.791462085337;20913;20954;21074.15703371863;1914.9712754308696;1962.5388033812042;1976.65408553504;2301.7007788987326;2401.5677178107935;12394.876051239462;12916.160449570747;12968.935155324258;13580.117292376062;13601.387937542835;1710.392810552261;1712.3150739704095;1766.3023105873108;1802.342145117023;1808.1953530678852;66201.33798662;67500;69283;70626.293737063;71898;9207.217386522087;9320.8601870972;9468.195203407788;9468.384555003902;9861.260405469618;13011.414486348138;13043.217406955613;13058.542950996669;13066.085374023916;13078.476860925457;6695.631740254333;6929.930700693029;7112.50212485121;7114.786556403316;7138.571685698875;6474.514411419068;6531.477481801445;6552.148220731275;6665.900011499832;6721;5875.236219291465;6031.396860314021;6032.577719559588;6112.786052488231;6165.568410211332;1675.5643532681347;1703.3016463250256;1705.6673948580155;1712.9828701712822;1746.3014794082214;800.7397595781395;892.5314210039651;900.3067637918766;915.3455279475074;925.8657494663236;16862.325506979585;16921.915390423215;17102;17722.556936076442;17915.820841791676;870.4037734151999;875.4572165257581;875.5315905990265;875.7810547363159;909.60432211988;9563.569639366246;10017.564228513485;10098.293119481566;10152.796944061078;10220.744481388025;369245;375829;378600;381127;381390;38917;45232.09535809331;45268.3209751854;66790.33209667938;67419.32580674229;784.4352066512103;873.7073080517971;893.78102364921;900.1088921967336;905.3617199874072;11394.94302528482;14546.927265363605;15036.473723419627;15073;15080.245987700791;34119.4882076774;34926;35656.10859728424;36065;36139.81930090333;41665.79167104145;46739.29891051705;47937.04125917392;52413.15248007388;52793.208101879274;7608;7626.237376262329;7724.304812566896;7765.689372425039;7788.88316675239;9511.476868772284;11487;11511;11618.6514404568;11661.475233614337;9826.75433114178;9844.803103938024;10103.444310562696;10374.429406382722;10413.739656508647;9754.463504507037;9850.655227067018;9973.252006099716;10044.849327260243;10096.848547271944;9766.902330976884;9843.40939543601;10132.645357412455;10348.521214765937;10384.065434110966;7342.743003994835;7462.365698915436;7588.962055189689;7710.267524585155;7738.458307918391;10015.349002314826;10092.94953525257;10227.846582301123;10439.739006524898;10531.684049478528 14:25:06 INFO - PROCESS | 10864 | |3;mootools.html;1342.8791408773209;1358.762216612093;1401.376387507559;1662.1107707376548;1663.2016632016623;6806.6256355900405;7473.775786726394;7517.097948246218;7983.441159118864;7992.040955085398;7536.133344665365;7841.960790196055;7843.803904902366;7854.60726963651;7857.646405911733;2159.924402645908;2189.321310393775;2191.2002119226527;2191.868487890724;2191.9890400548056;1851.1669748613178;2089.279198676454;2102.5899949509853;2136.305700647288;2153.5908177446313;2103.7054812326287;2131;2131.0516820015023;2131.0942849289067;2131.5630295789324;2080.126346934291;2092.612866619673;2123.225022866658;2125.3092744857827;2126.87238765673;2059.2998380550684;2071.85497015209;2082.833373330145;2086.9060892259886;2088.488320361506;7708.614569271514;7881.842363152705;7884.526928384258;7889.17163697815;7889.526628402315;4393.7363758174615;4487.41663583732;4490.259107247301;4491.977540112279;4493.258612328962;2806.2984253936515;2923.6637786654596;2971.895983640584;2982.4631566318053;2990.5065664165386;880.3353468131584;909.6497848328441;911.7128104647015;944.8204841080242;963.4700914496999;10291.33106348085;10324.948375258076;10331.380117192992;10337.53481093345;10343.534540945675;3744.0265530962147;3967.6032396760093;4071.2875246832277;4115.279826030433;4144.274751918402;9035.593398297093;9035.819283614292;9049.81900361989;9050.140236677506;9068.047854975133;4518.118966801508;4529.048899731093;4529.32060190974;4532.637389008872;4534.956959899242;4126.051008268115;4140.254754144283;4140.875773726793;4143.834246630101;4144.647704945053;3349.1627093226693;3376.4260075786683;3399.6600339965808;3432.0733401981324;3474.530938323294;957.5260246178048;1009.5406590001531;1030.3611760708409;1031.7626945802508;1043.8152696689313;671.2314400011959;691.8132104331802;752.6236881559221;781.7615627233635;791.4697152907565;4900.166971614834;4968.354113965162;4996.150654388763;5321.467853214725;5360.571154307646;809.732788179911;827.962741676614;865.6580650642961;866.3718803867146;882.0870399136991;3505.106197919565;3539.911502212465;3570.0360902556163;3645.0887278180453;3656.7623104498653;8859.29125669945;9586.95206523963;9756.658516951873;9763.26775491841;9777.31558790892;9664.806703865883;9677.98381169981;9682.515874206261;9685.564149613285;9689.467079310705;7092.503524753218;7398.778036658909;7428.145763237297;7450;7452.888206676904;4973.079980203529;5184.585233181412;5205.193195054772;5291.417944026077;5483.643563168382;8909.376343655882;8912.777180570278;8919.687810926587;9063.13900179482;9106.544672766468;8774.692885748967;8899.777505562413;9209.493477858514;9339.953300233456;9383.296252780932;6778.2205046420295;6923.515353925177;6928.064711263914;6941.271166527644;6945.236024037453;7429.925700742923;7477.990471286306;7484.962575187089;7486.92513074884;7488.363489103487;6633.369829866155;6636.83407914806;6687.933120668926;6731.46148308144;6870.519063665495;6602;6608.768693095719;6614.239362473185;6755.898661520179;6890.552114112566;5962.52299816005;6030.427109424598;6036.698165091816;6040.818775436744;6055.455009049207;4341.60925516705;4438.844640437569;4499.955000449953;4499.955000450084;4525.117602067565;4248.787560622019;4386.42976413077;4444.066745983379;4469.910601787881;4505.481869584909 14:25:06 INFO - PROCESS | 10864 | |4;prototype.html;284.1702229489891;290.2830009875608;293.4834690943938;294.7082388435449;304.60705689660347;4791.448983366914;4818.542238487338;4834.371531700878;4849.442314133871;4858.611311095113;4758.214894542396;4775.952240477594;4804.966932109595;4816.446108697501;4824.348712923755;3583.605803361622;3666.7799932004164;3792.2415516896594;3814.256220037094;3838.923221535568;3793.4499497572833;3801.33476641588;3815.5993620669847;3819.9045023874487;3826.196498735269;3758.1168425420005;3758.49260349852;3762.4168253920684;3764.623537646241;3790.223004284129;3584.766990145645;3663.19409729859;3779.60314167014;3783.3379158647404;3810.40938654509;3354.9496757548654;3364.327134573095;3365.478350855621;3374.5275661407422;3374.768209603477;4670.505438259758;4670.781378845056;4671.252599584084;4673.649476289292;4743.35964644772;4223.598758117974;4275.957240427618;4276.166147601219;4372.1692878353015;4373.453318335208;4974.552290293891;4982.202847544412;5007.474215207387;5009.624278179152;5016.774245158977;3607.9458808117897;3609.8917032488803;3614.8373323200517;3626.3291291111227;3632.673059424638;5074.568661663763;5156.587473002113;5174.249733788617;5187;5238.423773384925;3632.219072899339;3666.4500324950936;3667.431548110047;3679.3193259247123;3683.116052147519;3740.382836831947;3755.342815007363;3760.5111335526753;3777.697784177259;3781.357169281229;4264.912447325912;4270.188664153801;4289.67827412939;4297.162053399557;4300.935485967713;4817.566419022305;4958.281049247839;4974.686770651592;5011.323471331397;5068.746562671926;1307.2091384712303;1327.157255142972;1327.7145413736093;1330.7737684593642;1333.646583655332;823.9052508961427;830.4519017448455;863.6286396849415;874.8233625773324;875.8379699755566;4345.782710864444;4439.911201775946;4465.933011004838;4483.910321793611;4514.954850451519;5137.075326441276;5143.459936706667;5146.948530514722;5165.9483405165465;5178.352705911761;4460.643148548108;4495.820167193341;4497.235469970113;4498.190325741332;4512.774361281923;2561.987190064075;2716.7419095185924;2725.795565332608;2744.8764805583796;2748.051922086877;4872.78072486739;4903.975480122576;4907.509249075064;4907.9263811042865;4908.435529914034;5031.371078615173;5260.526552610207;5284.762185701576;5303.708296043755;5319.978408204857;4919.188333924933;4929.260610908393;4943.28322393251;4954.603631709527;4956.90086198274;5185.781341384847;5186.8962620748125;5190.948090519047;5214.139666955061;5229.450907654794;4903.117438860897;5085.5931525477135;5094.490550944876;5099.439061703136;5104.566111880532;4929.2359684248995;4935.975320123376;4937.160682683881;4938.481459446706;4940.654154209171;3681.650243226889;3687.9446808298435;3725.9068523287133;3738.9626103738615;3743.756655817363;5119.334486516729;5185.714071729227;5259;5273.128039545906;5285.5243028126115;5020.096382651158;5021.824236151717;5034.597232221487;5053.206111830247;5053.545180933586;5022.547970682656;5030.798768049237;5040;5059.785651443553;5064.848054558369;4808.7595620219545;4952.851414457572;4970;4989.750512474435;5002.324686167321;4802.4957379476045;4880.31675565414;5025.924611130909;5035.244713293036;5079.993402606024;4885.682430641997;4936.2102063669645;4942.0594746126;4951.554360107608;4958.256261560795 14:25:06 INFO - PROCESS | 10864 | |5;yui.html;599.8080614203456;620.252595622275;621.1738387944035;631.9730438038189;667.5827607745159;10068.899311006888;10248.231382646303;10267.897321026798;10278.126359259453;10311;12661.810072848915;12892.613221603344;13333.200007999503;13510.324483775796;14039.92980035101;696.0464164095197;716.7563028570285;719.3813320544327;720.3552820225894;720.6360787802153;608.2214765100679;718.2530168624651;744.7281742164125;746.4289818289013;756.8637645223857;781.8358144789601;782.1435528096754;783.4750717019582;783.6865253898429;784.8665726826454;779.0845756236399;779.6569509415839;780.3601047141346;780.6994307191716;780.742355022844;464.23633123511974;551.8841043380895;567.5487987050304;571.3657839797821;575.2406822993651;12102.515899364014;12127.211731237441;12143.392830358534;12146.817797733042;12159.027277817753;10098;10560.2079844012;10659.946700266526;11128.38793866337;11131.165162612837;11296.717582060432;11460.770784584261;11464.13233656754;11677.182597218198;11788.882111178864;3799.4900945408413;3821.636944490269;3867.8259478323544;3915.295246855593;3961.1483531040676;62001;62156.37843621551;62224;62229;62406.687966560334;7922.960385198037;8051.59742012897;8087.636056377477;8140.308073813674;8214.424990250745;14127.78808317876;14588.197649129399;14627.92686036563;14641.48754793577;14641.780373294408;6427;6541;6629.270780214172;6673.065770792093;6676.799696009128;3585.8924232273075;3592.694620957248;3653.4337177737493;3666.5233519642275;3764.6047165047275;2840.8295502269516;2950.51316532774;2975.910722678323;2976.4939960206816;2990.925226869302;515.1062905858333;522.7386306846577;523.6543881038497;528.7514868012029;538.6076990978365;455.39432554702165;509.20818127810867;516.1818517649492;517.4127365440178;532.5766016017276;6550.934490655032;6777.49168812341;7766.184550622216;7804.453688241882;7961.800954976056;492.3845193508115;532.9421099118247;537.9070345513298;540.5810496864962;542.9131338985743;3535;3587.9103022424124;3610.548681414823;3771.6605505504635;3773.8867833965023;62874;100796;100957.49521252494;103166.48416757869;103986;86494.56752716195;89104;89237.55381223053;90373;95346.52326738322;80632;80921.59539202266;81489;81958;82826;7114.608696521741;7170.96414517924;7220.74727384539;7555.395568354628;7588.241175882367;45372.546274536835;45495.54504454913;46660.300095499275;46747.532524674316;47789;66424.66787666031;69666.30333696598;71200.28799712144;71870.64064679852;72579.63710181415;8821.691240806798;8911.331650126396;8984.86522702173;9168.908310916806;9297.488638124969;10874.67375978722;10879.673609791718;11209.663710088711;11365.488553015299;11673.066154707432;10024.649137280161;10105.141063009727;10375.584976600852;10496.842547361643;10822.56709731602;9641.746572945473;9694.806103878023;9790.314677972474;10388.636397726043;10472.10987066108;9864.901350986398;9893.35693179941;9980.500974951368;10080.949595251977;10666.040056394962;8382.916170838458;8754.430961987451;8837.204651581389;8849.91150088491;9009.549522523717;9006.684766033157;9054.773630659287;9091.136342047495;9103.90896091057;9186.897572291367 14:25:06 INFO - PROCESS | 10864 | __end_tp_report 14:25:06 INFO - PROCESS | 10864 | __start_cc_report 14:25:06 INFO - PROCESS | 10864 | _x_x_mozilla_cycle_collect,996 14:25:06 INFO - PROCESS | 10864 | __end_cc_report 14:25:06 INFO - PROCESS | 10864 | __startTimestamp1472505906817__endTimestamp 14:25:06 INFO - PROCESS | 10864 | 14:25:06 INFO - PROCESS | 10864 | ------- Summary: start ------- 14:25:06 INFO - PROCESS | 10864 | Number of tests: 6 14:25:06 INFO - PROCESS | 10864 | 14:25:06 INFO - PROCESS | 10864 | [#0] dojo.html Cycles:165 Average:4627.43 Median:4761.43 stddev:479.70 (10.1%) stddev-sans-first:453.32 14:25:06 INFO - PROCESS | 10864 | Values: 2574.0 2579.5 2597.5 2605.4 2615.4 4530.5 4560.3 4610.1 4645.7 4699.7 4609.5 4651.5 4672.5 4683.4 4685.2 4244.3 4311.2 4316.8 4375.5 4386.8 4291.4 4298.9 4301.6 4408.7 4432.4 4331.5 4350.5 4404.7 4442.6 4444.2 4367.9 4398.3 4429.8 4448.7 4457.7 4218.2 4235.6 4259.3 4307.9 4311.6 4588.3 4602.2 4602.9 4618.5 4704.9 4964.1 4983.7 4997.1 5008.6 5067.7 4892.2 4943.7 5010.8 5018.3 5089.1 4662.1 4681.8 4681.9 4689.1 4690.4 5129.1 5138.5 5168.4 5190.0 5220.1 4817.3 4826.4 4916.2 4931.4 4933.3 4938.6 4965.2 4967.1 5005.4 5020.9 4896.4 4907.5 4908.4 4925.9 4976.9 4791.5 4852.8 4896.1 4912.5 4956.9 4200.5 4235.6 4241.9 4245.2 4278.4 3681.7 3683.6 3697.6 3718.1 3724.9 4251.6 4310.0 4314.1 4315.1 4359.8 4987.0 5010.7 5033.0 5087.6 5098.0 4352.5 4354.2 4358.4 4380.0 4407.1 4552.7 4559.6 4564.1 4567.6 4620.5 4594.1 4717.8 4757.3 4761.4 4767.5 5043.8 5046.7 5047.7 5053.3 5087.8 4739.5 4769.0 4777.3 4777.6 4818.5 4801.6 4881.3 4917.5 4931.5 5025.2 4986.9 5007.2 5007.7 5011.2 5055.0 4846.3 4847.5 4847.6 4848.3 4930.2 4769.0 4826.5 4849.6 4870.9 4932.5 4793.3 4800.6 4810.0 4858.2 4883.1 4911.7 4914.3 4915.7 4918.8 4977.7 4701.3 4750.8 4757.5 4790.8 4810.8 14:25:06 INFO - PROCESS | 10864 | 14:25:06 INFO - PROCESS | 10864 | [#1] ext.html Cycles:180 Average:46410.14 Median:34858.74 stddev:86985.40 (249.5%) stddev-sans-first:87161.29 14:25:06 INFO - PROCESS | 10864 | Values: 559.9 574.7 584.3 587.4 588.4 26978.2 36669.4 37975.9 38101.4 42058.2 39643.8 40389.8 40533.2 40533.3 40538.0 7664.5 7810.3 7815.0 7816.6 7818.9 7564.8 7629.3 7640.8 7641.4 7643.7 7466.6 7493.9 7506.2 7506.6 7511.2 7619.7 7636.9 7647.0 7650.0 7653.2 7652.7 7657.7 7720.5 7725.8 7728.5 37303.8 37536.4 37698.4 37707.4 37719.2 2914.9 2935.8 3051.0 3467.2 3595.7 27431.9 28023.7 28427.6 28695.0 28809.1 3365.3 3425.6 3444.6 3454.9 3493.1 272553.0 277636.0 278286.0 377096.0 379069.0 48757.3 49008.3 49034.5 49184.0 49209.3 28479.4 29227.7 29439.6 44516.6 44849.3 13508.4 13700.3 13750.3 13763.9 13764.2 10377.5 10482.1 10509.6 10516.7 10532.3 17461.0 17586.6 17613.2 17643.2 17723.7 6769.5 6788.4 6843.7 6853.5 6949.4 773.8 841.4 889.8 932.2 953.5 24129.6 24726.4 25121.9 25168.1 25246.6 792.5 898.9 909.7 940.4 1005.1 12905.6 13497.2 13736.7 13897.8 14048.3 378048.0 381428.0 382084.0 382361.0 383234.0 46881.0 47402.8 47417.8 47428.3 47429.8 1043.1 1108.7 1131.8 1151.1 1166.4 24616.8 27290.9 27903.6 28384.6 28940.9 33055.8 33399.2 33448.7 33452.8 33489.0 277066.0 278733.0 279805.0 279968.0 280702.0 24392.0 25191.7 25223.0 26132.2 26184.5 35128.3 35826.5 36248.8 36293.6 38482.0 34581.3 34589.3 34676.7 34867.0 34963.7 34125.5 34129.5 34275.3 34578.8 34668.3 34408.0 34850.5 34980.0 35110.5 35772.6 29943.3 32100.7 32346.4 32383.7 32555.5 24271.3 24597.8 24972.8 25066.5 25399.0 14:25:06 INFO - PROCESS | 10864 | 14:25:06 INFO - PROCESS | 10864 | [#2] jquery.html Cycles:180 Average:23211.97 Median:47338.17 stddev:61899.88 (130.8%) stddev-sans-first:62049.68 14:25:06 INFO - PROCESS | 10864 | Values: 330.7 350.0 350.3 352.8 369.3 12370.1 15469.8 16271.8 16317.0 17530.3 15958.5 16205.0 16232.2 16479.2 16643.4 4926.9 5061.3 5173.0 5174.5 5174.7 5737.2 5907.9 5924.3 5932.5 5938.7 5808.5 5857.5 5898.4 5907.1 5929.8 5871.1 5882.1 5898.8 5904.1 5906.0 4955.4 5106.2 5146.8 5171.1 5181.8 20752.9 20853.8 20913.0 20954.0 21074.2 1915.0 1962.5 1976.7 2301.7 2401.6 12394.9 12916.2 12968.9 13580.1 13601.4 1710.4 1712.3 1766.3 1802.3 1808.2 66201.3 67500.0 69283.0 70626.3 71898.0 9207.2 9320.9 9468.2 9468.4 9861.3 13011.4 13043.2 13058.5 13066.1 13078.5 6695.6 6929.9 7112.5 7114.8 7138.6 6474.5 6531.5 6552.1 6665.9 6721.0 5875.2 6031.4 6032.6 6112.8 6165.6 1675.6 1703.3 1705.7 1713.0 1746.3 800.7 892.5 900.3 915.3 925.9 16862.3 16921.9 17102.0 17722.6 17915.8 870.4 875.5 875.5 875.8 909.6 9563.6 10017.6 10098.3 10152.8 10220.7 369245.0 375829.0 378600.0 381127.0 381390.0 38917.0 45232.1 45268.3 66790.3 67419.3 784.4 873.7 893.8 900.1 905.4 11394.9 14546.9 15036.5 15073.0 15080.2 34119.5 34926.0 35656.1 36065.0 36139.8 41665.8 46739.3 47937.0 52413.2 52793.2 7608.0 7626.2 7724.3 7765.7 7788.9 9511.5 11487.0 11511.0 11618.7 11661.5 9826.8 9844.8 10103.4 10374.4 10413.7 9754.5 9850.7 9973.3 10044.8 10096.8 9766.9 9843.4 10132.6 10348.5 10384.1 7342.7 7462.4 7589.0 7710.3 7738.5 10015.3 10092.9 10227.8 10439.7 10531.7 14:25:06 INFO - PROCESS | 10864 | 14:25:06 INFO - PROCESS | 10864 | [#3] mootools.html Cycles:180 Average:5081.32 Median:5306.44 stddev:2889.10 (54.4%) stddev-sans-first:2883.54 14:25:06 INFO - PROCESS | 10864 | Values: 1342.9 1358.8 1401.4 1662.1 1663.2 6806.6 7473.8 7517.1 7983.4 7992.0 7536.1 7842.0 7843.8 7854.6 7857.6 2159.9 2189.3 2191.2 2191.9 2192.0 1851.2 2089.3 2102.6 2136.3 2153.6 2103.7 2131.0 2131.1 2131.1 2131.6 2080.1 2092.6 2123.2 2125.3 2126.9 2059.3 2071.9 2082.8 2086.9 2088.5 7708.6 7881.8 7884.5 7889.2 7889.5 4393.7 4487.4 4490.3 4492.0 4493.3 2806.3 2923.7 2971.9 2982.5 2990.5 880.3 909.6 911.7 944.8 963.5 10291.3 10324.9 10331.4 10337.5 10343.5 3744.0 3967.6 4071.3 4115.3 4144.3 9035.6 9035.8 9049.8 9050.1 9068.0 4518.1 4529.0 4529.3 4532.6 4535.0 4126.1 4140.3 4140.9 4143.8 4144.6 3349.2 3376.4 3399.7 3432.1 3474.5 957.5 1009.5 1030.4 1031.8 1043.8 671.2 691.8 752.6 781.8 791.5 4900.2 4968.4 4996.2 5321.5 5360.6 809.7 828.0 865.7 866.4 882.1 3505.1 3539.9 3570.0 3645.1 3656.8 8859.3 9587.0 9756.7 9763.3 9777.3 9664.8 9678.0 9682.5 9685.6 9689.5 7092.5 7398.8 7428.1 7450.0 7452.9 4973.1 5184.6 5205.2 5291.4 5483.6 8909.4 8912.8 8919.7 9063.1 9106.5 8774.7 8899.8 9209.5 9340.0 9383.3 6778.2 6923.5 6928.1 6941.3 6945.2 7429.9 7478.0 7485.0 7486.9 7488.4 6633.4 6636.8 6687.9 6731.5 6870.5 6602.0 6608.8 6614.2 6755.9 6890.6 5962.5 6030.4 6036.7 6040.8 6055.5 4341.6 4438.8 4500.0 4500.0 4525.1 4248.8 4386.4 4444.1 4469.9 4505.5 14:25:06 INFO - PROCESS | 10864 | 14:25:06 INFO - PROCESS | 10864 | [#4] prototype.html Cycles:180 Average:4191.59 Median:4812.60 stddev:1209.14 (25.1%) stddev-sans-first:1176.43 14:25:06 INFO - PROCESS | 10864 | Values: 284.2 290.3 293.5 294.7 304.6 4791.4 4818.5 4834.4 4849.4 4858.6 4758.2 4776.0 4805.0 4816.4 4824.3 3583.6 3666.8 3792.2 3814.3 3838.9 3793.4 3801.3 3815.6 3819.9 3826.2 3758.1 3758.5 3762.4 3764.6 3790.2 3584.8 3663.2 3779.6 3783.3 3810.4 3354.9 3364.3 3365.5 3374.5 3374.8 4670.5 4670.8 4671.3 4673.6 4743.4 4223.6 4276.0 4276.2 4372.2 4373.5 4974.6 4982.2 5007.5 5009.6 5016.8 3607.9 3609.9 3614.8 3626.3 3632.7 5074.6 5156.6 5174.2 5187.0 5238.4 3632.2 3666.5 3667.4 3679.3 3683.1 3740.4 3755.3 3760.5 3777.7 3781.4 4264.9 4270.2 4289.7 4297.2 4300.9 4817.6 4958.3 4974.7 5011.3 5068.7 1307.2 1327.2 1327.7 1330.8 1333.6 823.9 830.5 863.6 874.8 875.8 4345.8 4439.9 4465.9 4483.9 4515.0 5137.1 5143.5 5146.9 5165.9 5178.4 4460.6 4495.8 4497.2 4498.2 4512.8 2562.0 2716.7 2725.8 2744.9 2748.1 4872.8 4904.0 4907.5 4907.9 4908.4 5031.4 5260.5 5284.8 5303.7 5320.0 4919.2 4929.3 4943.3 4954.6 4956.9 5185.8 5186.9 5190.9 5214.1 5229.5 4903.1 5085.6 5094.5 5099.4 5104.6 4929.2 4936.0 4937.2 4938.5 4940.7 3681.7 3687.9 3725.9 3739.0 3743.8 5119.3 5185.7 5259.0 5273.1 5285.5 5020.1 5021.8 5034.6 5053.2 5053.5 5022.5 5030.8 5040.0 5059.8 5064.8 4808.8 4952.9 4970.0 4989.8 5002.3 4802.5 4880.3 5025.9 5035.2 5080.0 4885.7 4936.2 4942.1 4951.6 4958.3 14:25:06 INFO - PROCESS | 10864 | 14:25:06 INFO - PROCESS | 10864 | [#5] yui.html Cycles:180 Average:17644.95 Median:569.46 stddev:26709.50 (4690.3%) stddev-sans-first:26753.77 14:25:06 INFO - PROCESS | 10864 | Values: 599.8 620.3 621.2 632.0 667.6 10068.9 10248.2 10267.9 10278.1 10311.0 12661.8 12892.6 13333.2 13510.3 14039.9 696.0 716.8 719.4 720.4 720.6 608.2 718.3 744.7 746.4 756.9 781.8 782.1 783.5 783.7 784.9 779.1 779.7 780.4 780.7 780.7 464.2 551.9 567.5 571.4 575.2 12102.5 12127.2 12143.4 12146.8 12159.0 10098.0 10560.2 10659.9 11128.4 11131.2 11296.7 11460.8 11464.1 11677.2 11788.9 3799.5 3821.6 3867.8 3915.3 3961.1 62001.0 62156.4 62224.0 62229.0 62406.7 7923.0 8051.6 8087.6 8140.3 8214.4 14127.8 14588.2 14627.9 14641.5 14641.8 6427.0 6541.0 6629.3 6673.1 6676.8 3585.9 3592.7 3653.4 3666.5 3764.6 2840.8 2950.5 2975.9 2976.5 2990.9 515.1 522.7 523.7 528.8 538.6 455.4 509.2 516.2 517.4 532.6 6550.9 6777.5 7766.2 7804.5 7961.8 492.4 532.9 537.9 540.6 542.9 3535.0 3587.9 3610.5 3771.7 3773.9 62874.0 100796.0 100957.5 103166.5 103986.0 86494.6 89104.0 89237.6 90373.0 95346.5 80632.0 80921.6 81489.0 81958.0 82826.0 7114.6 7171.0 7220.7 7555.4 7588.2 45372.5 45495.5 46660.3 46747.5 47789.0 66424.7 69666.3 71200.3 71870.6 72579.6 8821.7 8911.3 8984.9 9168.9 9297.5 10874.7 10879.7 11209.7 11365.5 11673.1 10024.6 10105.1 10375.6 10496.8 10822.6 9641.7 9694.8 9790.3 10388.6 10472.1 9864.9 9893.4 9980.5 10080.9 10666.0 8382.9 8754.4 8837.2 8849.9 9009.5 9006.7 9054.8 9091.1 9103.9 9186.9 14:25:06 INFO - PROCESS | 10864 | -------- Summary: end -------- 14:25:06 INFO - PROCESS | 10864 | 14:25:07 INFO - TEST-INFO | 10864: exit 0 14:25:07 INFO - TEST-OK | dromaeo_css | took 1120759ms 14:25:07 INFO - TEST-START | kraken 14:25:07 INFO - operating with platform_type : linux_ 14:25:07 INFO - Initialising browser for kraken test... 14:25:07 INFO - TEST-INFO | started process 11174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7atzXf/profile http://localhost:40866/getInfo.html) 14:25:12 INFO - PROCESS | 11174 | __metrics Screen width/height:1600/1200 14:25:12 INFO - PROCESS | 11174 | colorDepth:24 14:25:12 INFO - PROCESS | 11174 | Browser inner width/height: 1024/697 14:25:12 INFO - PROCESS | 11174 | __metrics 14:25:12 INFO - PROCESS | 11174 | 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" 14:25:12 INFO - PROCESS | 11174 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:25:13 INFO - PROCESS | 11174 | console.error: PushService: 14:25:13 INFO - PROCESS | 11174 | stateChangeProcessEnqueue: Error transitioning state 14:25:13 INFO - PROCESS | 11174 | UnknownError 14:25:14 INFO - TEST-INFO | 11174: exit 0 14:25:14 INFO - Browser initialized. 14:25:14 INFO - Running cycle 1/1 for kraken test... 14:25:14 INFO - TEST-INFO | started process 11252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7atzXf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:26 INFO - PROCESS | 11252 | RSS: Main: 182001664 14:25:26 INFO - PROCESS | 11252 | 14:25:28 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40866/tests/kraken/driver.html?testName=audio-beat-detection) 14:25:29 INFO - PROCESS | 11252 | RSS: Main: 243298304 14:25:29 INFO - PROCESS | 11252 | 14:25:32 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40866/tests/kraken/driver.html?testName=audio-dft) 14:25:33 INFO - PROCESS | 11252 | RSS: Main: 227110912 14:25:33 INFO - PROCESS | 11252 | 14:25:36 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40866/tests/kraken/driver.html?testName=audio-fft) 14:25:37 INFO - PROCESS | 11252 | RSS: Main: 303738880 14:25:37 INFO - PROCESS | 11252 | 14:25:39 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40866/tests/kraken/driver.html?testName=audio-oscillator) 14:25:39 INFO - PROCESS | 11252 | RSS: Main: 214228992 14:25:39 INFO - PROCESS | 11252 | 14:25:42 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40866/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:25:42 INFO - PROCESS | 11252 | RSS: Main: 215601152 14:25:42 INFO - PROCESS | 11252 | 14:25:45 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40866/tests/kraken/driver.html?testName=imaging-darkroom) 14:25:46 INFO - PROCESS | 11252 | RSS: Main: 254099456 14:25:46 INFO - PROCESS | 11252 | 14:25:49 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40866/tests/kraken/driver.html?testName=imaging-desaturate) 14:25:50 INFO - PROCESS | 11252 | RSS: Main: 253747200 14:25:50 INFO - PROCESS | 11252 | 14:25:53 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40866/tests/kraken/driver.html?testName=json-parse-financial) 14:25:54 INFO - PROCESS | 11252 | RSS: Main: 252485632 14:25:54 INFO - PROCESS | 11252 | 14:25:55 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40866/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:25:56 INFO - PROCESS | 11252 | RSS: Main: 215691264 14:25:56 INFO - PROCESS | 11252 | 14:25:58 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:25:58 INFO - PROCESS | 11252 | RSS: Main: 223260672 14:25:58 INFO - PROCESS | 11252 | 14:26:01 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:26:01 INFO - PROCESS | 11252 | RSS: Main: 224018432 14:26:01 INFO - PROCESS | 11252 | 14:26:04 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:26:05 INFO - PROCESS | 11252 | RSS: Main: 225247232 14:26:05 INFO - PROCESS | 11252 | 14:26:08 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:26:08 INFO - PROCESS | 11252 | RSS: Main: 223248384 14:26:08 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40866/tests/kraken/driver.html?testName=ai-astar) 14:26:10 INFO - PROCESS | 11252 | RSS: Main: 273752064 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | __start_tp_report 14:26:10 INFO - PROCESS | 11252 | _x_x_mozilla_page_load 14:26:10 INFO - PROCESS | 11252 | _x_x_mozilla_page_load_details 14:26:10 INFO - PROCESS | 11252 | |i|pagename|runs| 14:26:10 INFO - PROCESS | 11252 | |0;ai-astar;114;114;133;115;114;116;117;114;113;114 14:26:10 INFO - PROCESS | 11252 | |1;audio-beat-detection;153;122;151;183;129;147;153;123;197;125 14:26:10 INFO - PROCESS | 11252 | |2;audio-dft;162;162;164;164;161;163;161;164;164;161 14:26:10 INFO - PROCESS | 11252 | |3;audio-fft;74;76;76;158;78;75;76;78;152;77 14:26:10 INFO - PROCESS | 11252 | |4;audio-oscillator;83;83;142;84;85;84;132;83;83;143 14:26:10 INFO - PROCESS | 11252 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;118;117;118 14:26:10 INFO - PROCESS | 11252 | |6;imaging-darkroom;148;147;146;146;148;146;145;146;148;146 14:26:10 INFO - PROCESS | 11252 | |7;imaging-desaturate;95;94;94;94;95;95;95;95;95;96 14:26:10 INFO - PROCESS | 11252 | |8;json-parse-financial;63;66;65;77;65;64;64;65;65;64 14:26:10 INFO - PROCESS | 11252 | |9;json-stringify-tinderbox;67;67;66;65;67;65;66;65;66;66 14:26:10 INFO - PROCESS | 11252 | |10;stanford-crypto-aes;88;83;82;82;83;82;91;83;81;82 14:26:10 INFO - PROCESS | 11252 | |11;stanford-crypto-ccm;132;131;132;132;129;131;135;146;181;138 14:26:10 INFO - PROCESS | 11252 | |12;stanford-crypto-pbkdf2;178;176;170;170;170;171;171;171;170;177 14:26:10 INFO - PROCESS | 11252 | |13;stanford-crypto-sha256-iterative;69;70;68;71;69;68;68;68;67;67 14:26:10 INFO - PROCESS | 11252 | __end_tp_report 14:26:10 INFO - PROCESS | 11252 | __start_cc_report 14:26:10 INFO - PROCESS | 11252 | _x_x_mozilla_cycle_collect,2024 14:26:10 INFO - PROCESS | 11252 | __end_cc_report 14:26:10 INFO - PROCESS | 11252 | __startTimestamp1472505970804__endTimestamp 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | ------- Summary: start ------- 14:26:10 INFO - PROCESS | 11252 | Number of tests: 14 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#0] ai-astar Cycles:10 Average:116.40 Median:114.50 stddev:5.95 (5.2%) stddev-sans-first:6.24 14:26:10 INFO - PROCESS | 11252 | Values: 114.0 114.0 133.0 115.0 114.0 116.0 117.0 114.0 113.0 114.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:152.00 stddev:25.55 (16.8%) stddev-sans-first:27.05 14:26:10 INFO - PROCESS | 11252 | Values: 153.0 122.0 151.0 183.0 129.0 147.0 153.0 123.0 197.0 125.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 14:26:10 INFO - PROCESS | 11252 | Values: 162.0 162.0 164.0 164.0 161.0 163.0 161.0 164.0 164.0 161.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#3] audio-fft Cycles:10 Average:92.00 Median:76.00 stddev:33.26 (43.8%) stddev-sans-first:34.63 14:26:10 INFO - PROCESS | 11252 | Values: 74.0 76.0 76.0 158.0 78.0 75.0 76.0 78.0 152.0 77.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#4] audio-oscillator Cycles:10 Average:100.20 Median:83.00 stddev:26.94 (32.5%) stddev-sans-first:27.84 14:26:10 INFO - PROCESS | 11252 | Values: 83.0 83.0 142.0 84.0 85.0 84.0 132.0 83.0 83.0 143.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:26:10 INFO - PROCESS | 11252 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 14:26:10 INFO - PROCESS | 11252 | Values: 148.0 147.0 146.0 146.0 148.0 146.0 145.0 146.0 148.0 146.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:26:10 INFO - PROCESS | 11252 | Values: 95.0 94.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:65.00 stddev:4.02 (6.2%) stddev-sans-first:4.14 14:26:10 INFO - PROCESS | 11252 | Values: 63.0 66.0 65.0 77.0 65.0 64.0 64.0 65.0 65.0 64.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 14:26:10 INFO - PROCESS | 11252 | Values: 67.0 67.0 66.0 65.0 67.0 65.0 66.0 65.0 66.0 66.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:3.20 (3.9%) stddev-sans-first:2.99 14:26:10 INFO - PROCESS | 11252 | Values: 88.0 83.0 82.0 82.0 83.0 82.0 91.0 83.0 81.0 82.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:133.50 stddev:15.65 (11.7%) stddev-sans-first:16.41 14:26:10 INFO - PROCESS | 11252 | Values: 132.0 131.0 132.0 132.0 129.0 131.0 135.0 146.0 181.0 138.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:171.00 stddev:3.24 (1.9%) stddev-sans-first:2.73 14:26:10 INFO - PROCESS | 11252 | Values: 178.0 176.0 170.0 170.0 170.0 171.0 171.0 171.0 170.0 177.0 14:26:10 INFO - PROCESS | 11252 | 14:26:10 INFO - PROCESS | 11252 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.27 (1.9%) stddev-sans-first:1.33 14:26:10 INFO - PROCESS | 11252 | Values: 69.0 70.0 68.0 71.0 69.0 68.0 68.0 68.0 67.0 67.0 14:26:10 INFO - PROCESS | 11252 | -------- Summary: end -------- 14:26:10 INFO - PROCESS | 11252 | 14:26:12 INFO - TEST-INFO | 11252: exit 0 14:26:12 INFO - TEST-OK | kraken | took 64400ms 14:26:12 INFO - SUITE-END | took 1185s 14:26:12 INFO - Completed test suite (00:19:45) 14:26:12 INFO - javascript benchmark 14:26:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.009006532485, 2579.5356835769553, 2597.5194589001035, 2605.426806102658, 2615.4246065865514, 4530.501644819067, 4560.270356742922, 4610.077984403116, 4645.721256724599, 4699.694519856207, 4609.516000819907, 4651.5348465153465, 4672.5327467253255, 4683.4379874415035, 4685.2269375553, 4244.278472659647, 4311.202427550913, 4316.82732690692, 4375.496817865938, 4386.824527018932, 4291.4421125253675, 4298.914021719564, 4301.591348821857, 4408.735475871442, 4432.3794668746405, 4331.523532411448, 4350.54319296474, 4404.69167158299, 4442.600165985061, 4444.17782710198, 4367.890802729926, 4398.34024896265, 4429.844955426561, 4448.666350023761, 4457.732536047847, 4218.1985422769885, 4235.597618226264, 4259.318509038539, 4307.892302692458, 4311.6335111515555, 4588.334691469719, 4602.1946159422305, 4602.941323495615, 4618.468876079227, 4704.905901881977, 4964.081644895669, 4983.72589507577, 4997.075541024922, 5008.62435317349, 5067.746612669352, 4892.192788189945, 4943.728094954776, 5010.774515146827, 5018.272350509193, 5089.134847076006, 4662.067586482717, 4681.789319480631, 4681.859544213611, 4689.062187562501, 4690.413698287714, 5129.051125541787, 5138.4604616514725, 5168.431472538018, 5190.039842629126, 5220.060389129993, 4817.349657796222, 4826.420829500412, 4916.237983112624, 4931.432885218174, 4933.309336692866, 4938.604911607063, 4965.155923493015, 4967.05625931072, 5005.399352077701, 5020.895403011332, 4896.436909755353, 4907.460179380265, 4908.435529914105, 4925.901481970341, 4976.900461990812, 4791.520847915181, 4852.8301509447, 4896.094222568836, 4912.459629440758, 4956.851294461172, 4200.5169405518145, 4235.576442355739, 4241.851535196253, 4245.23585754561, 4278.422412974271, 3681.742278040565, 3683.594804571495, 3697.6302369762807, 3718.1448266898765, 3724.944125838115, 4251.574842515785, 4309.978450107729, 4314.115606300764, 4315.050688848449, 4359.760213188241, 4987.0, 5010.724410157403, 5033.018561380496, 5087.567556757643, 5097.974510127426, 4352.499462561846, 4354.238008348526, 4358.36803663467, 4379.956200438019, 4407.118576284756, 4552.681312308173, 4559.6124329431705, 4564.132814765184, 4567.63458923292, 4620.5379462053525, 4594.081183763194, 4717.764111794465, 4757.26262429324, 4761.428628564595, 4767.547083027107, 5043.798248070036, 5046.747662616928, 5047.671901326549, 5053.26727624485, 5087.771050302671, 4739.478657347758, 4768.976155119202, 4777.3311736356245, 4777.570018698334, 4818.494058123846, 4801.639877009308, 4881.267809828412, 4917.459079501181, 4931.457539670705, 5025.246213068069, 4986.8753281168265, 5007.223880298559, 5007.7496125192865, 5011.173156429149, 5055.014272216882, 4846.297286893451, 4847.515248475124, 4847.61219102478, 4848.32123502717, 4930.161872481615, 4769.022350418225, 4826.469088400203, 4849.563539281482, 4870.853874383774, 4932.45742968266, 4793.304970779148, 4800.567948884477, 4809.975950120367, 4858.198397264412, 4883.121038213156, 4911.656184067081, 4914.311996320589, 4915.680480768739, 4918.827841025547, 4977.651564390458, 4701.318308845267, 4750.8337208197545, 4757.476677565396, 4790.832320868893, 4810.831620893252], "value": 4596.742562067237, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.9216109744636, 574.7183879898851, 584.2842517915553, 587.3949831673375, 588.3792598808255, 26978.190654280355, 36669.44995825065, 37975.86072417828, 38101.428478572845, 42058.15883682332, 39643.801780991125, 40389.79805100978, 40533.189336213334, 40533.338666053416, 40538.0, 7664.540127592349, 7810.258025487569, 7814.960925195366, 7816.648250828698, 7818.921810781876, 7564.773056808304, 7629.313361797437, 7640.847183056336, 7641.4268929830205, 7643.732469363574, 7466.626668666572, 7493.850122997536, 7506.249375062477, 7506.62466876654, 7511.211322811108, 7619.695212191506, 7636.885446718304, 7647.0, 7650.043744531906, 7653.196414376466, 7652.655630496641, 7657.731979380695, 7720.459567830254, 7725.806854828618, 7728.536287822749, 37303.813480932695, 37536.43695344572, 37698.43452348217, 37707.434388484195, 37719.24561508782, 2914.8688309026143, 2935.809172403808, 3050.9847450762604, 3467.1678797088516, 3595.694365978895, 27431.86284068567, 28023.73893174812, 28427.57358639622, 28695.0, 28809.135725928256, 3365.2764655599162, 3425.5889293284963, 3444.6383129771266, 3454.8790792322397, 3493.074335301147, 272553.0, 277636.0, 278286.0, 377096.0, 379069.0, 48757.26864097041, 49008.264876026886, 49034.50965490299, 49184.0, 49209.26186107211, 28479.43041139207, 29227.707722922925, 29439.558406623917, 44516.55483445124, 44849.32726009112, 13508.392122354519, 13700.314984250748, 13750.312484375741, 13763.862361376257, 13764.17414955106, 10377.481125943672, 10482.056614904543, 10509.632162874263, 10516.68449946503, 10532.315399499008, 17461.0, 17586.648267034587, 17613.207405666777, 17643.20605572752, 17723.73414398785, 6769.458443324522, 6788.355106264897, 6843.657817109125, 6853.485988550879, 6949.44404447643, 773.7756050745334, 841.448851002582, 889.7775556110972, 932.2215949681956, 953.4898829126384, 24129.638055429183, 24726.381840454134, 25121.874390628294, 25168.119115830857, 25246.621300680505, 792.4769652029632, 898.9101089890959, 909.7225346269319, 940.416941496263, 1005.100435110572, 12905.612831615066, 13497.190168589916, 13736.65658358529, 13897.79153312701, 14048.26058918501, 378048.0, 381428.0, 382084.0, 382361.0, 383234.0, 46881.0, 47402.76298618485, 47417.76291118591, 47428.288575671395, 47429.76285118552, 1043.1133536494071, 1108.6563165418584, 1131.8472006279046, 1151.1308961733837, 1166.445938179358, 24616.753832462164, 27290.86354568294, 27903.581446277916, 28384.57423138696, 28940.855295723388, 33055.83472082624, 33399.16502087467, 33448.66551334455, 33452.832735836164, 33489.0, 277066.0, 278733.0, 279805.0, 279968.0, 280702.0, 24392.0, 25191.74808251894, 25222.99108035658, 26132.216033519024, 26184.476310473303, 35128.29743405169, 35826.462603061496, 36248.81875590605, 36293.63706362902, 38482.0379490515, 34581.30837383188, 34589.308213836084, 34676.65323346835, 34867.0, 34963.65036349604, 34125.48811767875, 34129.48805767965, 34275.31449371049, 34578.82710586431, 34668.306633866676, 34408.0, 34850.47724284087, 34980.0, 35110.47334290039, 35772.64227357693, 29943.251418714706, 32100.678993209767, 32346.353072937938, 32383.676163238066, 32555.511667324536, 24271.271861844172, 24597.754022460264, 24972.75136243217, 25066.498670026864, 25399.0], "value": 16707.26688666151, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.7106282003247, 349.97375196860236, 350.32911973570606, 352.8324046078113, 369.30201918374263, 12370.13409061365, 15469.767953480692, 16271.755923661154, 16317.02097874127, 17530.298788048494, 15958.521244362688, 16205.0, 16232.188390580453, 16479.176041197952, 16643.41748038819, 4926.876828079291, 5061.266116413118, 5173.0, 5174.456682048387, 5174.715390653512, 5737.168110623957, 5907.88184236315, 5924.259467566554, 5932.466078052975, 5938.732757025922, 5808.5023439920815, 5857.531397488191, 5898.439648233432, 5907.084401917709, 5929.762809487615, 5871.089981052944, 5882.117682347639, 5898.8230353089475, 5904.0553511437965, 5905.970470147665, 4955.380577427822, 5106.234064890259, 5146.794128234867, 5171.069207542679, 5181.792728290864, 20752.896235518878, 20853.791462085337, 20913.0, 20954.0, 21074.15703371863, 1914.9712754308696, 1962.5388033812042, 1976.65408553504, 2301.7007788987326, 2401.5677178107935, 12394.876051239462, 12916.160449570747, 12968.935155324258, 13580.117292376062, 13601.387937542835, 1710.392810552261, 1712.3150739704095, 1766.3023105873108, 1802.342145117023, 1808.1953530678852, 66201.33798662, 67500.0, 69283.0, 70626.293737063, 71898.0, 9207.217386522087, 9320.8601870972, 9468.195203407788, 9468.384555003902, 9861.260405469618, 13011.414486348138, 13043.217406955613, 13058.542950996669, 13066.085374023916, 13078.476860925457, 6695.631740254333, 6929.930700693029, 7112.50212485121, 7114.786556403316, 7138.571685698875, 6474.514411419068, 6531.477481801445, 6552.148220731275, 6665.900011499832, 6721.0, 5875.236219291465, 6031.396860314021, 6032.577719559588, 6112.786052488231, 6165.568410211332, 1675.5643532681347, 1703.3016463250256, 1705.6673948580155, 1712.9828701712822, 1746.3014794082214, 800.7397595781395, 892.5314210039651, 900.3067637918766, 915.3455279475074, 925.8657494663236, 16862.325506979585, 16921.915390423215, 17102.0, 17722.556936076442, 17915.820841791676, 870.4037734151999, 875.4572165257581, 875.5315905990265, 875.7810547363159, 909.60432211988, 9563.569639366246, 10017.564228513485, 10098.293119481566, 10152.796944061078, 10220.744481388025, 369245.0, 375829.0, 378600.0, 381127.0, 381390.0, 38917.0, 45232.09535809331, 45268.3209751854, 66790.33209667938, 67419.32580674229, 784.4352066512103, 873.7073080517971, 893.78102364921, 900.1088921967336, 905.3617199874072, 11394.94302528482, 14546.927265363605, 15036.473723419627, 15073.0, 15080.245987700791, 34119.4882076774, 34926.0, 35656.10859728424, 36065.0, 36139.81930090333, 41665.79167104145, 46739.29891051705, 47937.04125917392, 52413.15248007388, 52793.208101879274, 7608.0, 7626.237376262329, 7724.304812566896, 7765.689372425039, 7788.88316675239, 9511.476868772284, 11487.0, 11511.0, 11618.6514404568, 11661.475233614337, 9826.75433114178, 9844.803103938024, 10103.444310562696, 10374.429406382722, 10413.739656508647, 9754.463504507037, 9850.655227067018, 9973.252006099716, 10044.849327260243, 10096.848547271944, 9766.902330976884, 9843.40939543601, 10132.645357412455, 10348.521214765937, 10384.065434110966, 7342.743003994835, 7462.365698915436, 7588.962055189689, 7710.267524585155, 7738.458307918391, 10015.349002314826, 10092.94953525257, 10227.846582301123, 10439.739006524898, 10531.684049478528], "value": 8192.383647609671, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.8791408773209, 1358.762216612093, 1401.376387507559, 1662.1107707376548, 1663.2016632016623, 6806.6256355900405, 7473.775786726394, 7517.097948246218, 7983.441159118864, 7992.040955085398, 7536.133344665365, 7841.960790196055, 7843.803904902366, 7854.60726963651, 7857.646405911733, 2159.924402645908, 2189.321310393775, 2191.2002119226527, 2191.868487890724, 2191.9890400548056, 1851.1669748613178, 2089.279198676454, 2102.5899949509853, 2136.305700647288, 2153.5908177446313, 2103.7054812326287, 2131.0, 2131.0516820015023, 2131.0942849289067, 2131.5630295789324, 2080.126346934291, 2092.612866619673, 2123.225022866658, 2125.3092744857827, 2126.87238765673, 2059.2998380550684, 2071.85497015209, 2082.833373330145, 2086.9060892259886, 2088.488320361506, 7708.614569271514, 7881.842363152705, 7884.526928384258, 7889.17163697815, 7889.526628402315, 4393.7363758174615, 4487.41663583732, 4490.259107247301, 4491.977540112279, 4493.258612328962, 2806.2984253936515, 2923.6637786654596, 2971.895983640584, 2982.4631566318053, 2990.5065664165386, 880.3353468131584, 909.6497848328441, 911.7128104647015, 944.8204841080242, 963.4700914496999, 10291.33106348085, 10324.948375258076, 10331.380117192992, 10337.53481093345, 10343.534540945675, 3744.0265530962147, 3967.6032396760093, 4071.2875246832277, 4115.279826030433, 4144.274751918402, 9035.593398297093, 9035.819283614292, 9049.81900361989, 9050.140236677506, 9068.047854975133, 4518.118966801508, 4529.048899731093, 4529.32060190974, 4532.637389008872, 4534.956959899242, 4126.051008268115, 4140.254754144283, 4140.875773726793, 4143.834246630101, 4144.647704945053, 3349.1627093226693, 3376.4260075786683, 3399.6600339965808, 3432.0733401981324, 3474.530938323294, 957.5260246178048, 1009.5406590001531, 1030.3611760708409, 1031.7626945802508, 1043.8152696689313, 671.2314400011959, 691.8132104331802, 752.6236881559221, 781.7615627233635, 791.4697152907565, 4900.166971614834, 4968.354113965162, 4996.150654388763, 5321.467853214725, 5360.571154307646, 809.732788179911, 827.962741676614, 865.6580650642961, 866.3718803867146, 882.0870399136991, 3505.106197919565, 3539.911502212465, 3570.0360902556163, 3645.0887278180453, 3656.7623104498653, 8859.29125669945, 9586.95206523963, 9756.658516951873, 9763.26775491841, 9777.31558790892, 9664.806703865883, 9677.98381169981, 9682.515874206261, 9685.564149613285, 9689.467079310705, 7092.503524753218, 7398.778036658909, 7428.145763237297, 7450.0, 7452.888206676904, 4973.079980203529, 5184.585233181412, 5205.193195054772, 5291.417944026077, 5483.643563168382, 8909.376343655882, 8912.777180570278, 8919.687810926587, 9063.13900179482, 9106.544672766468, 8774.692885748967, 8899.777505562413, 9209.493477858514, 9339.953300233456, 9383.296252780932, 6778.2205046420295, 6923.515353925177, 6928.064711263914, 6941.271166527644, 6945.236024037453, 7429.925700742923, 7477.990471286306, 7484.962575187089, 7486.92513074884, 7488.363489103487, 6633.369829866155, 6636.83407914806, 6687.933120668926, 6731.46148308144, 6870.519063665495, 6602.0, 6608.768693095719, 6614.239362473185, 6755.898661520179, 6890.552114112566, 5962.52299816005, 6030.427109424598, 6036.698165091816, 6040.818775436744, 6055.455009049207, 4341.60925516705, 4438.844640437569, 4499.955000449953, 4499.955000450084, 4525.117602067565, 4248.787560622019, 4386.42976413077, 4444.066745983379, 4469.910601787881, 4505.481869584909], "value": 4056.5262498628854, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.1702229489891, 290.2830009875608, 293.4834690943938, 294.7082388435449, 304.60705689660347, 4791.448983366914, 4818.542238487338, 4834.371531700878, 4849.442314133871, 4858.611311095113, 4758.214894542396, 4775.952240477594, 4804.966932109595, 4816.446108697501, 4824.348712923755, 3583.605803361622, 3666.7799932004164, 3792.2415516896594, 3814.256220037094, 3838.923221535568, 3793.4499497572833, 3801.33476641588, 3815.5993620669847, 3819.9045023874487, 3826.196498735269, 3758.1168425420005, 3758.49260349852, 3762.4168253920684, 3764.623537646241, 3790.223004284129, 3584.766990145645, 3663.19409729859, 3779.60314167014, 3783.3379158647404, 3810.40938654509, 3354.9496757548654, 3364.327134573095, 3365.478350855621, 3374.5275661407422, 3374.768209603477, 4670.505438259758, 4670.781378845056, 4671.252599584084, 4673.649476289292, 4743.35964644772, 4223.598758117974, 4275.957240427618, 4276.166147601219, 4372.1692878353015, 4373.453318335208, 4974.552290293891, 4982.202847544412, 5007.474215207387, 5009.624278179152, 5016.774245158977, 3607.9458808117897, 3609.8917032488803, 3614.8373323200517, 3626.3291291111227, 3632.673059424638, 5074.568661663763, 5156.587473002113, 5174.249733788617, 5187.0, 5238.423773384925, 3632.219072899339, 3666.4500324950936, 3667.431548110047, 3679.3193259247123, 3683.116052147519, 3740.382836831947, 3755.342815007363, 3760.5111335526753, 3777.697784177259, 3781.357169281229, 4264.912447325912, 4270.188664153801, 4289.67827412939, 4297.162053399557, 4300.935485967713, 4817.566419022305, 4958.281049247839, 4974.686770651592, 5011.323471331397, 5068.746562671926, 1307.2091384712303, 1327.157255142972, 1327.7145413736093, 1330.7737684593642, 1333.646583655332, 823.9052508961427, 830.4519017448455, 863.6286396849415, 874.8233625773324, 875.8379699755566, 4345.782710864444, 4439.911201775946, 4465.933011004838, 4483.910321793611, 4514.954850451519, 5137.075326441276, 5143.459936706667, 5146.948530514722, 5165.9483405165465, 5178.352705911761, 4460.643148548108, 4495.820167193341, 4497.235469970113, 4498.190325741332, 4512.774361281923, 2561.987190064075, 2716.7419095185924, 2725.795565332608, 2744.8764805583796, 2748.051922086877, 4872.78072486739, 4903.975480122576, 4907.509249075064, 4907.9263811042865, 4908.435529914034, 5031.371078615173, 5260.526552610207, 5284.762185701576, 5303.708296043755, 5319.978408204857, 4919.188333924933, 4929.260610908393, 4943.28322393251, 4954.603631709527, 4956.90086198274, 5185.781341384847, 5186.8962620748125, 5190.948090519047, 5214.139666955061, 5229.450907654794, 4903.117438860897, 5085.5931525477135, 5094.490550944876, 5099.439061703136, 5104.566111880532, 4929.2359684248995, 4935.975320123376, 4937.160682683881, 4938.481459446706, 4940.654154209171, 3681.650243226889, 3687.9446808298435, 3725.9068523287133, 3738.9626103738615, 3743.756655817363, 5119.334486516729, 5185.714071729227, 5259.0, 5273.128039545906, 5285.5243028126115, 5020.096382651158, 5021.824236151717, 5034.597232221487, 5053.206111830247, 5053.545180933586, 5022.547970682656, 5030.798768049237, 5040.0, 5059.785651443553, 5064.848054558369, 4808.7595620219545, 4952.851414457572, 4970.0, 4989.750512474435, 5002.324686167321, 4802.4957379476045, 4880.31675565414, 5025.924611130909, 5035.244713293036, 5079.993402606024, 4885.682430641997, 4936.2102063669645, 4942.0594746126, 4951.554360107608, 4958.256261560795], "value": 3805.7393478709896, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8080614203456, 620.252595622275, 621.1738387944035, 631.9730438038189, 667.5827607745159, 10068.899311006888, 10248.231382646303, 10267.897321026798, 10278.126359259453, 10311.0, 12661.810072848915, 12892.613221603344, 13333.200007999503, 13510.324483775796, 14039.92980035101, 696.0464164095197, 716.7563028570285, 719.3813320544327, 720.3552820225894, 720.6360787802153, 608.2214765100679, 718.2530168624651, 744.7281742164125, 746.4289818289013, 756.8637645223857, 781.8358144789601, 782.1435528096754, 783.4750717019582, 783.6865253898429, 784.8665726826454, 779.0845756236399, 779.6569509415839, 780.3601047141346, 780.6994307191716, 780.742355022844, 464.23633123511974, 551.8841043380895, 567.5487987050304, 571.3657839797821, 575.2406822993651, 12102.515899364014, 12127.211731237441, 12143.392830358534, 12146.817797733042, 12159.027277817753, 10098.0, 10560.2079844012, 10659.946700266526, 11128.38793866337, 11131.165162612837, 11296.717582060432, 11460.770784584261, 11464.13233656754, 11677.182597218198, 11788.882111178864, 3799.4900945408413, 3821.636944490269, 3867.8259478323544, 3915.295246855593, 3961.1483531040676, 62001.0, 62156.37843621551, 62224.0, 62229.0, 62406.687966560334, 7922.960385198037, 8051.59742012897, 8087.636056377477, 8140.308073813674, 8214.424990250745, 14127.78808317876, 14588.197649129399, 14627.92686036563, 14641.48754793577, 14641.780373294408, 6427.0, 6541.0, 6629.270780214172, 6673.065770792093, 6676.799696009128, 3585.8924232273075, 3592.694620957248, 3653.4337177737493, 3666.5233519642275, 3764.6047165047275, 2840.8295502269516, 2950.51316532774, 2975.910722678323, 2976.4939960206816, 2990.925226869302, 515.1062905858333, 522.7386306846577, 523.6543881038497, 528.7514868012029, 538.6076990978365, 455.39432554702165, 509.20818127810867, 516.1818517649492, 517.4127365440178, 532.5766016017276, 6550.934490655032, 6777.49168812341, 7766.184550622216, 7804.453688241882, 7961.800954976056, 492.3845193508115, 532.9421099118247, 537.9070345513298, 540.5810496864962, 542.9131338985743, 3535.0, 3587.9103022424124, 3610.548681414823, 3771.6605505504635, 3773.8867833965023, 62874.0, 100796.0, 100957.49521252494, 103166.48416757869, 103986.0, 86494.56752716195, 89104.0, 89237.55381223053, 90373.0, 95346.52326738322, 80632.0, 80921.59539202266, 81489.0, 81958.0, 82826.0, 7114.608696521741, 7170.96414517924, 7220.74727384539, 7555.395568354628, 7588.241175882367, 45372.546274536835, 45495.54504454913, 46660.300095499275, 46747.532524674316, 47789.0, 66424.66787666031, 69666.30333696598, 71200.28799712144, 71870.64064679852, 72579.63710181415, 8821.691240806798, 8911.331650126396, 8984.86522702173, 9168.908310916806, 9297.488638124969, 10874.67375978722, 10879.673609791718, 11209.663710088711, 11365.488553015299, 11673.066154707432, 10024.649137280161, 10105.141063009727, 10375.584976600852, 10496.842547361643, 10822.56709731602, 9641.746572945473, 9694.806103878023, 9790.314677972474, 10388.636397726043, 10472.10987066108, 9864.901350986398, 9893.35693179941, 9980.500974951368, 10080.949595251977, 10666.040056394962, 8382.916170838458, 8754.430961987451, 8837.204651581389, 8849.91150088491, 9009.549522523717, 9006.684766033157, 9054.773630659287, 9091.136342047495, 9103.90896091057, 9186.897572291367], "value": 6139.416503584167, "unit": "score"}], "name": "dromaeo_css", "value": 6250.610939116664, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 133.0, 115.0, 114.0, 116.0, 117.0, 114.0, 113.0, 114.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 151.0, 183.0, 129.0, 147.0, 153.0, 123.0, 197.0, 125.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 164.0, 161.0, 163.0, 161.0, 164.0, 164.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 158.0, 78.0, 75.0, 76.0, 78.0, 152.0, 77.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 142.0, 84.0, 85.0, 84.0, 132.0, 83.0, 83.0, 143.0], "value": 100.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 148.0, 146.0, 145.0, 146.0, 148.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 77.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 65.0, 67.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 82.0, 82.0, 83.0, 82.0, 91.0, 83.0, 81.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 132.0, 132.0, 129.0, 131.0, 135.0, 146.0, 181.0, 138.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 170.0, 170.0, 170.0, 171.0, 171.0, 171.0, 170.0, 177.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 71.0, 69.0, 68.0, 68.0, 68.0, 67.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1573.4000000000003, "alertThreshold": 2.0}]} 14:26:12 INFO - Return code: 0 14:26:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:26:12 INFO - # TBPL SUCCESS # 14:26:12 INFO - Running post-action listener: _resource_record_post_action 14:26:12 INFO - [mozharness: 2016-08-29 21:26:12.634406Z] Finished run-tests step (success) 14:26:12 INFO - Running post-run listener: _resource_record_post_run 14:26:12 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 385024; Write bytes: 408133632; Read time: 256; Write time: 219584 14:26:12 INFO - TinderboxPrint: CPU usage
13.0% 14:26:12 INFO - TinderboxPrint: I/O read bytes / time
385,024 / 256 14:26:12 INFO - TinderboxPrint: I/O write bytes / time
408,133,632 / 219,584 14:26:12 INFO - TinderboxPrint: CPU idle
8,342.8 (87.0%) 14:26:12 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 14:26:12 INFO - TinderboxPrint: Swap in / out
0 / 0 14:26:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113610752; Read time: 0; Write time: 71896 14:26:12 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 385024; Write bytes: 293621760; Read time: 256; Write time: 147656 14:26:13 INFO - Running post-run listener: _upload_blobber_files 14:26:13 INFO - Blob upload gear active. 14:26:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:26:13 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 14:26:13 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'] 14:26:13 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 14:26:13 INFO - (blobuploader) - INFO - Open directory for files ... 14:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:26:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:15 INFO - (blobuploader) - INFO - Done attempting. 14:26:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:26:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:26:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:16 INFO - (blobuploader) - INFO - Done attempting. 14:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:23 INFO - (blobuploader) - INFO - Done attempting. 14:26:23 INFO - (blobuploader) - INFO - Iteration through files over. 14:26:23 INFO - Return code: 0 14:26:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:26:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:26:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4ef4d19fa6aa2252ed4708ccd456ce6987497672a00388c49e18dbe38e38566edf198d6e456e5105b5bee4d9098145df129e342b7a24e8b5751d743ee7894f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20cc844610a1d5e1a89a305dcee681543cc2a1a37662f1d53e78a6e97681f3cb53edd6ab20ebf3ddd9454b9d8e4890c28a3ec514ee84f4e2d8e0cbb40323df0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/550f97fe8ba76ca7b0bbffb23f82f9f1d81bfcaa7ea8712a368ef929b5f9def7f618fb69bdf4555df168afb06498bc5d3a72704f07e65331337c3a5bd9709dc7"} 14:26:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:26:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:26:23 INFO - Contents: 14:26:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4ef4d19fa6aa2252ed4708ccd456ce6987497672a00388c49e18dbe38e38566edf198d6e456e5105b5bee4d9098145df129e342b7a24e8b5751d743ee7894f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20cc844610a1d5e1a89a305dcee681543cc2a1a37662f1d53e78a6e97681f3cb53edd6ab20ebf3ddd9454b9d8e4890c28a3ec514ee84f4e2d8e0cbb40323df0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/550f97fe8ba76ca7b0bbffb23f82f9f1d81bfcaa7ea8712a368ef929b5f9def7f618fb69bdf4555df168afb06498bc5d3a72704f07e65331337c3a5bd9709dc7"} 14:26:23 INFO - Running post-run listener: copy_logs_to_upload_dir 14:26:23 INFO - Copying logs to upload dir... 14:26:23 INFO - mkdir: /builds/slave/test/build/upload/logs 14:26:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.332921 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-29 14:26:23.240134) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 14:26:23.243494) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182 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/4ef4d19fa6aa2252ed4708ccd456ce6987497672a00388c49e18dbe38e38566edf198d6e456e5105b5bee4d9098145df129e342b7a24e8b5751d743ee7894f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20cc844610a1d5e1a89a305dcee681543cc2a1a37662f1d53e78a6e97681f3cb53edd6ab20ebf3ddd9454b9d8e4890c28a3ec514ee84f4e2d8e0cbb40323df0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/550f97fe8ba76ca7b0bbffb23f82f9f1d81bfcaa7ea8712a368ef929b5f9def7f618fb69bdf4555df168afb06498bc5d3a72704f07e65331337c3a5bd9709dc7"} build_url:https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/FMSnIsqOTNWSUEZLnGtjHg/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/4ef4d19fa6aa2252ed4708ccd456ce6987497672a00388c49e18dbe38e38566edf198d6e456e5105b5bee4d9098145df129e342b7a24e8b5751d743ee7894f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20cc844610a1d5e1a89a305dcee681543cc2a1a37662f1d53e78a6e97681f3cb53edd6ab20ebf3ddd9454b9d8e4890c28a3ec514ee84f4e2d8e0cbb40323df0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/550f97fe8ba76ca7b0bbffb23f82f9f1d81bfcaa7ea8712a368ef929b5f9def7f618fb69bdf4555df168afb06498bc5d3a72704f07e65331337c3a5bd9709dc7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 14:26:23.269912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 14:26:23.270321) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472504731.274660-1970005182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 14:26:23.353693) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 14:26:23.354089) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 14:26:23.354438) ========= ========= Total master_lag: 0.17 =========