builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1470797811.15 results: success (0) buildid: 20160809173001 builduid: 6435277cc98240df8c74c5b73a4d7486 revision: 13abad48dfb674a240bc019ab7c7305504f1eb93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:51.150086) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:51.150533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:51.150872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:51.175761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:51.176055) ========= 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=41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 19:56:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-08-09 19:56:51 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091153 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:51.281631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:51.281942) ========= 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=41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014963 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:51.337262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:51.337584) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 13abad48dfb674a240bc019ab7c7305504f1eb93 --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 13abad48dfb674a240bc019ab7c7305504f1eb93 --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=41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 19:56:51,538 truncating revision to first 12 chars 2016-08-09 19:56:51,538 Setting DEBUG logging. 2016-08-09 19:56:51,538 attempt 1/10 2016-08-09 19:56:51,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/13abad48dfb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 19:56:51,925 unpacking tar archive at: fx-team-13abad48dfb6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.711659 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:52.065817) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:52.066136) ========= script_repo_revision: 13abad48dfb674a240bc019ab7c7305504f1eb93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:52.066552) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:52.066836) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 19:56:52.077969) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-09 19:56:52.078340) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:56:52 INFO - MultiFileLogger online at 20160809 19:56:52 in /builds/slave/test 19:56:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:56:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:56:52 INFO - {'append_to_log': False, 19:56:52 INFO - 'base_work_dir': '/builds/slave/test', 19:56:52 INFO - 'blob_upload_branch': 'Fx-Team', 19:56:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:56:52 INFO - 'branch': 'Fx-Team', 19:56:52 INFO - 'buildbot_json_path': 'buildprops.json', 19:56:52 INFO - 'config_files': ('talos/linux_config.py',), 19:56:52 INFO - 'default_actions': ('clobber', 19:56:52 INFO - 'read-buildbot-config', 19:56:52 INFO - 'download-and-extract', 19:56:52 INFO - 'populate-webroot', 19:56:52 INFO - 'create-virtualenv', 19:56:52 INFO - 'install', 19:56:52 INFO - 'run-tests'), 19:56:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:56:52 INFO - 'download_minidump_stackwalk': True, 19:56:52 INFO - 'download_symbols': 'ondemand', 19:56:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:56:52 INFO - 'tooltool.py': '/tools/tooltool.py', 19:56:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:56:52 INFO - '/tools/misc-python/virtualenv.py')}, 19:56:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:56:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:56:52 INFO - 'installer_path': 'installer.exe', 19:56:52 INFO - 'log_level': 'info', 19:56:52 INFO - 'log_name': 'talos', 19:56:52 INFO - 'log_to_console': True, 19:56:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:56:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:56:52 INFO - 'opt_config_files': (), 19:56:52 INFO - 'pip_index': False, 19:56:52 INFO - 'sps_profile': False, 19:56:52 INFO - 'sps_profile_interval': 0, 19:56:52 INFO - 'suite': 'dromaeojs', 19:56:52 INFO - 'system_bits': '32', 19:56:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:56:52 INFO - 'title': 'talos-linux64-ix-026', 19:56:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:56:52 INFO - 'use_talos_json': True, 19:56:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:56:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:56:52 INFO - 'work_dir': 'build'} 19:56:52 INFO - [mozharness: 2016-08-10 02:56:52.376876Z] Running clobber step. 19:56:52 INFO - Running pre-action listener: _resource_record_pre_action 19:56:52 INFO - Running main action method: clobber 19:56:52 INFO - rmtree: /builds/slave/test/build 19:56:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:56:52 INFO - Running post-action listener: _resource_record_post_action 19:56:52 INFO - [mozharness: 2016-08-10 02:56:52.827920Z] Finished clobber step (success) 19:56:52 INFO - [mozharness: 2016-08-10 02:56:52.828021Z] Running read-buildbot-config step. 19:56:52 INFO - Running pre-action listener: _resource_record_pre_action 19:56:52 INFO - Running main action method: read_buildbot_config 19:56:52 INFO - Using buildbot properties: 19:56:52 INFO - { 19:56:52 INFO - "project": "", 19:56:52 INFO - "product": "firefox", 19:56:52 INFO - "script_repo_revision": "production", 19:56:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:56:52 INFO - "repository": "", 19:56:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:56:52 INFO - "buildid": "20160809173001", 19:56:52 INFO - "pgo_build": "True", 19:56:52 INFO - "basedir": "/builds/slave/test", 19:56:52 INFO - "buildnumber": 967, 19:56:52 INFO - "slavename": "talos-linux64-ix-026", 19:56:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:56:52 INFO - "platform": "ubuntu64_hw", 19:56:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:56:52 INFO - "branch": "fx-team", 19:56:52 INFO - "repo_path": "integration/fx-team", 19:56:52 INFO - "revision": "13abad48dfb674a240bc019ab7c7305504f1eb93", 19:56:52 INFO - "stage_platform": "linux64-pgo", 19:56:52 INFO - "builduid": "6435277cc98240df8c74c5b73a4d7486", 19:56:52 INFO - "slavebuilddir": "test" 19:56:52 INFO - } 19:56:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:56:52 INFO - Running post-action listener: _resource_record_post_action 19:56:52 INFO - [mozharness: 2016-08-10 02:56:52.830448Z] Finished read-buildbot-config step (success) 19:56:52 INFO - [mozharness: 2016-08-10 02:56:52.830538Z] Running download-and-extract step. 19:56:52 INFO - Running pre-action listener: _resource_record_pre_action 19:56:52 INFO - Running main action method: download_and_extract 19:56:52 INFO - mkdir: /builds/slave/test/build/tests 19:56:52 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')]} 19:56:52 INFO - trying https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:56:52 INFO - Downloading https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 19:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 19:56:53 INFO - Downloaded 1361 bytes. 19:56:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:56:53 INFO - Using the following test package requirements: 19:56:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:56:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:56:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:53 INFO - u'jsshell-linux-x86_64.zip'], 19:56:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:56:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:56:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:56:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:56:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:56:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:56: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')]} 19:56:53 INFO - trying https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:56:53 INFO - Downloading https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 19:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 19:56:54 INFO - Downloaded 21831225 bytes. 19:56:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:56:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:56:55 INFO - Return code: 0 19:56:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:55 INFO - trying https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:56:55 INFO - Downloading https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 19:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 19:56:56 INFO - Downloaded 21831225 bytes. 19:56:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:56:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:56:57 INFO - Return code: 0 19:56:57 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')]} 19:56:57 INFO - trying https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:57 INFO - Downloading https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 19:56:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 19:56:59 INFO - Downloaded 14413723 bytes. 19:56:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:56:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:56:59 INFO - Return code: 0 19:56:59 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')]} 19:56:59 INFO - trying https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:56:59 INFO - Downloading https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 19:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 19:57:02 INFO - Downloaded 59331046 bytes. 19:57:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:57:02 INFO - mkdir: /builds/slave/test/properties 19:57:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:57:02 INFO - Writing to file /builds/slave/test/properties/build_url 19:57:02 INFO - Contents: 19:57:02 INFO - build_url:https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:57:02 INFO - Running post-action listener: _resource_record_post_action 19:57:02 INFO - Running post-action listener: set_extra_try_arguments 19:57:02 INFO - [mozharness: 2016-08-10 02:57:02.723199Z] Finished download-and-extract step (success) 19:57:02 INFO - [mozharness: 2016-08-10 02:57:02.723432Z] Running populate-webroot step. 19:57:02 INFO - Running pre-action listener: _resource_record_pre_action 19:57:02 INFO - Running main action method: populate_webroot 19:57:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:57:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:57:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:57:02 INFO - '--tppagecycles', 19:57:02 INFO - '7'], 19:57:02 INFO - 'tests': ['tsvgm']}}, 19:57:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:57:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:57:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:57:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:57:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:02 INFO - 'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:02 INFO - 'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['damp', 'tps']}, 19:57:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:02 INFO - 'tests': ['damp', 'tps']}, 19:57:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['dromaeo_dom']}, 19:57:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:57:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['basic_compositor_video']}, 19:57:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:57:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['a11yr', 19:57:02 INFO - 'ts_paint', 19:57:02 INFO - 'tpaint', 19:57:02 INFO - 'sessionrestore', 19:57:02 INFO - 'sessionrestore_no_auto_restore', 19:57:02 INFO - 'tabpaint']}, 19:57:02 INFO - 'other-e10s': {'tests': ['a11yr', 19:57:02 INFO - 'ts_paint', 19:57:02 INFO - 'tpaint', 19:57:02 INFO - 'sessionrestore', 19:57:02 INFO - 'sessionrestore_no_auto_restore', 19:57:02 INFO - 'tabpaint']}, 19:57:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:57:02 INFO - 'ts_paint', 19:57:02 INFO - 'tpaint', 19:57:02 INFO - 'sessionrestore', 19:57:02 INFO - 'sessionrestore_no_auto_restore', 19:57:02 INFO - 'tabpaint']}, 19:57:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:57:02 INFO - 'ts_paint', 19:57:02 INFO - 'tpaint', 19:57:02 INFO - 'sessionrestore', 19:57:02 INFO - 'sessionrestore_no_auto_restore', 19:57:02 INFO - 'tabpaint']}, 19:57:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['a11yr', 19:57:02 INFO - 'ts_paint', 19:57:02 INFO - 'tpaint', 19:57:02 INFO - 'sessionrestore', 19:57:02 INFO - 'sessionrestore_no_auto_restore', 19:57:02 INFO - 'tabpaint']}, 19:57:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['a11yr', 19:57:02 INFO - 'ts_paint', 19:57:02 INFO - 'tpaint', 19:57:02 INFO - 'sessionrestore', 19:57:02 INFO - 'sessionrestore_no_auto_restore', 19:57:02 INFO - 'tabpaint']}, 19:57:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['tsvgx', 19:57:02 INFO - 'tsvgr_opacity', 19:57:02 INFO - 'tart', 19:57:02 INFO - 'tscrollx', 19:57:02 INFO - 'cart']}, 19:57:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:57:02 INFO - 'tsvgr_opacity', 19:57:02 INFO - 'tart', 19:57:02 INFO - 'tscrollx', 19:57:02 INFO - 'cart']}, 19:57:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:02 INFO - 'talos_options': ['--disable-e10s'], 19:57:02 INFO - 'tests': ['tp5o']}, 19:57:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:02 INFO - 'tests': ['tp5o']}, 19:57:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:02 INFO - 'talos_options': ['--disable-e10s', 19:57:02 INFO - '--xperf_path', 19:57:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:02 INFO - 'tests': ['tp5n']}, 19:57:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:02 INFO - 'talos_options': ['--xperf_path', 19:57:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:02 INFO - 'tests': ['tp5n']}}, 19:57:02 INFO - 'talos.zip': {'path': '', 19:57:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:57:02 INFO - Running post-action listener: _resource_record_post_action 19:57:02 INFO - [mozharness: 2016-08-10 02:57:02.742974Z] Finished populate-webroot step (success) 19:57:02 INFO - [mozharness: 2016-08-10 02:57:02.743062Z] Running create-virtualenv step. 19:57:02 INFO - Running pre-action listener: _resource_record_pre_action 19:57:02 INFO - Running main action method: create_virtualenv 19:57:02 INFO - Creating virtualenv /builds/slave/test/build/venv 19:57:02 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 19:57:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:57:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:57:02 INFO - Using real prefix '/usr' 19:57:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:57:03 INFO - Installing distribute.............................................................................................................................................................................................done. 19:57:05 INFO - Installing pip.................done. 19:57:05 INFO - Return code: 0 19:57:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:57: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')]} 19:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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')]} 19:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, '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': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', '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 19:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:57:05 INFO - Using env: {'DISPLAY': ':0', 19:57:05 INFO - 'HOME': '/home/cltbld', 19:57:05 INFO - 'LANG': 'en_US.UTF-8', 19:57:05 INFO - 'LANGUAGE': 'en_US:en', 19:57:05 INFO - 'LOGNAME': 'cltbld', 19:57:05 INFO - 'MAIL': '/var/mail/cltbld', 19:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:05 INFO - 'MOZ_NO_REMOTE': '1', 19:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:05 INFO - 'NO_EM_RESTART': '1', 19:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:05 INFO - 'PWD': '/builds/slave/test', 19:57:05 INFO - 'SHELL': '/bin/bash', 19:57:05 INFO - 'SHLVL': '1', 19:57:05 INFO - 'TERM': 'linux', 19:57:05 INFO - 'TMOUT': '86400', 19:57:05 INFO - 'USER': 'cltbld', 19:57:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:05 INFO - '_': '/tools/buildbot/bin/python'} 19:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:05 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 19:57:05 INFO - Cleaning up... 19:57:05 INFO - Return code: 0 19:57:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:57: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')]} 19:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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')]} 19:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, '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': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', '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 19:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:57:05 INFO - Using env: {'DISPLAY': ':0', 19:57:05 INFO - 'HOME': '/home/cltbld', 19:57:05 INFO - 'LANG': 'en_US.UTF-8', 19:57:05 INFO - 'LANGUAGE': 'en_US:en', 19:57:05 INFO - 'LOGNAME': 'cltbld', 19:57:05 INFO - 'MAIL': '/var/mail/cltbld', 19:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:05 INFO - 'MOZ_NO_REMOTE': '1', 19:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:05 INFO - 'NO_EM_RESTART': '1', 19:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:05 INFO - 'PWD': '/builds/slave/test', 19:57:05 INFO - 'SHELL': '/bin/bash', 19:57:05 INFO - 'SHLVL': '1', 19:57:05 INFO - 'TERM': 'linux', 19:57:05 INFO - 'TMOUT': '86400', 19:57:05 INFO - 'USER': 'cltbld', 19:57:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:05 INFO - '_': '/tools/buildbot/bin/python'} 19:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:05 INFO - Downloading/unpacking psutil>=3.1.1 19:57:05 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 19:57:05 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 19:57:05 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 19:57:05 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 19:57:05 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 19:57:05 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 19:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:57:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:07 INFO - Installing collected packages: psutil 19:57:07 INFO - Running setup.py install for psutil 19:57:07 INFO - building 'psutil._psutil_linux' extension 19:57:07 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 19:57:07 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 19:57:07 INFO - building 'psutil._psutil_posix' extension 19:57:07 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 19:57:08 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 19:57:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:08 INFO - Successfully installed psutil 19:57:08 INFO - Cleaning up... 19:57:08 INFO - Return code: 0 19:57:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:57:08 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')]} 19:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:08 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')]} 19:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:08 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, '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': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', '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 19:57:08 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 19:57:08 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 19:57:08 INFO - Using env: {'DISPLAY': ':0', 19:57:08 INFO - 'HOME': '/home/cltbld', 19:57:08 INFO - 'LANG': 'en_US.UTF-8', 19:57:08 INFO - 'LANGUAGE': 'en_US:en', 19:57:08 INFO - 'LOGNAME': 'cltbld', 19:57:08 INFO - 'MAIL': '/var/mail/cltbld', 19:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:08 INFO - 'MOZ_NO_REMOTE': '1', 19:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:08 INFO - 'NO_EM_RESTART': '1', 19:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:08 INFO - 'PWD': '/builds/slave/test', 19:57:08 INFO - 'SHELL': '/bin/bash', 19:57:08 INFO - 'SHLVL': '1', 19:57:08 INFO - 'TERM': 'linux', 19:57:08 INFO - 'TMOUT': '86400', 19:57:08 INFO - 'USER': 'cltbld', 19:57:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:08 INFO - '_': '/tools/buildbot/bin/python'} 19:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:57:08 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 19:57:08 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 19:57:08 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 19:57:08 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 19:57:08 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 19:57:08 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 19:57:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:57:10 INFO - Installing collected packages: mozsystemmonitor 19:57:10 INFO - Running setup.py install for mozsystemmonitor 19:57:10 INFO - Successfully installed mozsystemmonitor 19:57:10 INFO - Cleaning up... 19:57:10 INFO - Return code: 0 19:57:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, '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': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', '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 19:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:57:10 INFO - Using env: {'DISPLAY': ':0', 19:57:10 INFO - 'HOME': '/home/cltbld', 19:57:10 INFO - 'LANG': 'en_US.UTF-8', 19:57:10 INFO - 'LANGUAGE': 'en_US:en', 19:57:10 INFO - 'LOGNAME': 'cltbld', 19:57:10 INFO - 'MAIL': '/var/mail/cltbld', 19:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:10 INFO - 'MOZ_NO_REMOTE': '1', 19:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:10 INFO - 'NO_EM_RESTART': '1', 19:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:10 INFO - 'PWD': '/builds/slave/test', 19:57:10 INFO - 'SHELL': '/bin/bash', 19:57:10 INFO - 'SHLVL': '1', 19:57:10 INFO - 'TERM': 'linux', 19:57:10 INFO - 'TMOUT': '86400', 19:57:10 INFO - 'USER': 'cltbld', 19:57:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:10 INFO - '_': '/tools/buildbot/bin/python'} 19:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:10 INFO - Downloading/unpacking jsonschema==2.5.1 19:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:57:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:57:12 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 19:57:12 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 19:57:12 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 19:57:12 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 19:57:12 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 19:57:12 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 19:57:12 INFO - Downloading functools32-3.2.3-2.tar.gz 19:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:57:12 INFO - warning: no files found matching '*.txt' 19:57:12 INFO - no previously-included directories found matching 'build' 19:57:12 INFO - no previously-included directories found matching 'dist' 19:57:12 INFO - no previously-included directories found matching '.git*' 19:57:12 INFO - Installing collected packages: jsonschema, functools32 19:57:12 INFO - Running setup.py install for functools32 19:57:13 INFO - warning: no files found matching '*.txt' 19:57:13 INFO - no previously-included directories found matching 'build' 19:57:13 INFO - no previously-included directories found matching 'dist' 19:57:13 INFO - no previously-included directories found matching '.git*' 19:57:13 INFO - Successfully installed jsonschema functools32 19:57:13 INFO - Cleaning up... 19:57:13 INFO - Return code: 0 19:57:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:13 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, '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': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', '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 19:57:13 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 19:57:13 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 19:57:13 INFO - Using env: {'DISPLAY': ':0', 19:57:13 INFO - 'HOME': '/home/cltbld', 19:57:13 INFO - 'LANG': 'en_US.UTF-8', 19:57:13 INFO - 'LANGUAGE': 'en_US:en', 19:57:13 INFO - 'LOGNAME': 'cltbld', 19:57:13 INFO - 'MAIL': '/var/mail/cltbld', 19:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:13 INFO - 'MOZ_NO_REMOTE': '1', 19:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:13 INFO - 'NO_EM_RESTART': '1', 19:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:13 INFO - 'PWD': '/builds/slave/test', 19:57:13 INFO - 'SHELL': '/bin/bash', 19:57:13 INFO - 'SHLVL': '1', 19:57:13 INFO - 'TERM': 'linux', 19:57:13 INFO - 'TMOUT': '86400', 19:57:13 INFO - 'USER': 'cltbld', 19:57:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:13 INFO - '_': '/tools/buildbot/bin/python'} 19:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:57:13 INFO - Cleaning up... 19:57:13 INFO - Return code: 0 19:57:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:13 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, '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': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', '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 19:57:13 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 19:57:13 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 19:57:13 INFO - Using env: {'DISPLAY': ':0', 19:57:13 INFO - 'HOME': '/home/cltbld', 19:57:13 INFO - 'LANG': 'en_US.UTF-8', 19:57:13 INFO - 'LANGUAGE': 'en_US:en', 19:57:13 INFO - 'LOGNAME': 'cltbld', 19:57:13 INFO - 'MAIL': '/var/mail/cltbld', 19:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:13 INFO - 'MOZ_NO_REMOTE': '1', 19:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:13 INFO - 'NO_EM_RESTART': '1', 19:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:13 INFO - 'PWD': '/builds/slave/test', 19:57:13 INFO - 'SHELL': '/bin/bash', 19:57:13 INFO - 'SHLVL': '1', 19:57:13 INFO - 'TERM': 'linux', 19:57:13 INFO - 'TMOUT': '86400', 19:57:13 INFO - 'USER': 'cltbld', 19:57:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:13 INFO - '_': '/tools/buildbot/bin/python'} 19:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:13 INFO - Downloading/unpacking blobuploader==1.2.4 19:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:57:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:57:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:16 INFO - Downloading docopt-0.6.1.tar.gz 19:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:57:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:57:16 INFO - Running setup.py install for blobuploader 19:57:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:57:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:57:16 INFO - Running setup.py install for requests 19:57:16 INFO - Running setup.py install for docopt 19:57:16 INFO - Successfully installed blobuploader requests docopt 19:57:16 INFO - Cleaning up... 19:57:16 INFO - Return code: 0 19:57:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:16 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, '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': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', '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 19:57:16 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 19:57:16 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 19:57:16 INFO - Using env: {'DISPLAY': ':0', 19:57:16 INFO - 'HOME': '/home/cltbld', 19:57:16 INFO - 'LANG': 'en_US.UTF-8', 19:57:16 INFO - 'LANGUAGE': 'en_US:en', 19:57:16 INFO - 'LOGNAME': 'cltbld', 19:57:16 INFO - 'MAIL': '/var/mail/cltbld', 19:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:16 INFO - 'MOZ_NO_REMOTE': '1', 19:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:16 INFO - 'NO_EM_RESTART': '1', 19:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:16 INFO - 'PWD': '/builds/slave/test', 19:57:16 INFO - 'SHELL': '/bin/bash', 19:57:16 INFO - 'SHLVL': '1', 19:57:16 INFO - 'TERM': 'linux', 19:57:16 INFO - 'TMOUT': '86400', 19:57:16 INFO - 'USER': 'cltbld', 19:57:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:16 INFO - '_': '/tools/buildbot/bin/python'} 19:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:57:16 INFO - Running setup.py (path:/tmp/pip-HnLHCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:57:17 INFO - Running setup.py (path:/tmp/pip-t6omAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:57:17 INFO - Running setup.py (path:/tmp/pip-s8MedX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:57:17 INFO - Running setup.py (path:/tmp/pip-Q0eg5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:57:17 INFO - Running setup.py (path:/tmp/pip-NyznYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:57:17 INFO - Running setup.py (path:/tmp/pip-07TM30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:57:17 INFO - Running setup.py (path:/tmp/pip-S2UwSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:57:17 INFO - Running setup.py (path:/tmp/pip-uafTqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:57:17 INFO - Running setup.py (path:/tmp/pip-jDA3Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:57:17 INFO - Running setup.py (path:/tmp/pip-fj8dHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:57:17 INFO - Running setup.py (path:/tmp/pip-Dms_Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:57:17 INFO - Running setup.py (path:/tmp/pip-XkQSns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:57:17 INFO - Running setup.py (path:/tmp/pip-sJPGbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:57:17 INFO - Running setup.py (path:/tmp/pip-1DMT_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:17 INFO - Running setup.py (path:/tmp/pip-iS5FY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:57:18 INFO - Running setup.py (path:/tmp/pip-OBBBni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:57:18 INFO - Running setup.py (path:/tmp/pip-p5j7Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:57:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:57:18 INFO - Running setup.py install for manifestparser 19:57:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:57:18 INFO - Running setup.py install for mozcrash 19:57:18 INFO - Running setup.py install for mozdebug 19:57:18 INFO - Running setup.py install for mozdevice 19:57:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:57:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:57:18 INFO - Running setup.py install for mozfile 19:57:18 INFO - Running setup.py install for mozhttpd 19:57:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:57:18 INFO - Running setup.py install for mozinfo 19:57:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:57:18 INFO - Running setup.py install for mozInstall 19:57:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:57:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:57:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:57:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:57:19 INFO - Running setup.py install for mozleak 19:57:19 INFO - Running setup.py install for mozlog 19:57:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:57:19 INFO - Running setup.py install for moznetwork 19:57:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:57:19 INFO - Running setup.py install for mozprocess 19:57:19 INFO - Running setup.py install for mozprofile 19:57:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:57:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:57:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:57:19 INFO - Running setup.py install for mozrunner 19:57:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:57:19 INFO - Running setup.py install for mozscreenshot 19:57:19 INFO - Running setup.py install for moztest 19:57:19 INFO - Running setup.py install for mozversion 19:57:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:57:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:57:19 INFO - Cleaning up... 19:57:19 INFO - Return code: 0 19:57:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:20 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')]} 19:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:20 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, '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': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', '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 19:57:20 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 19:57:20 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 19:57:20 INFO - Using env: {'DISPLAY': ':0', 19:57:20 INFO - 'HOME': '/home/cltbld', 19:57:20 INFO - 'LANG': 'en_US.UTF-8', 19:57:20 INFO - 'LANGUAGE': 'en_US:en', 19:57:20 INFO - 'LOGNAME': 'cltbld', 19:57:20 INFO - 'MAIL': '/var/mail/cltbld', 19:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:20 INFO - 'MOZ_NO_REMOTE': '1', 19:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:20 INFO - 'NO_EM_RESTART': '1', 19:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:20 INFO - 'PWD': '/builds/slave/test', 19:57:20 INFO - 'SHELL': '/bin/bash', 19:57:20 INFO - 'SHLVL': '1', 19:57:20 INFO - 'TERM': 'linux', 19:57:20 INFO - 'TMOUT': '86400', 19:57:20 INFO - 'USER': 'cltbld', 19:57:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:20 INFO - '_': '/tools/buildbot/bin/python'} 19:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:57:20 INFO - Running setup.py (path:/tmp/pip-o6eoEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:57:20 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)) 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:57:20 INFO - Running setup.py (path:/tmp/pip-6YIe_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:57:20 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)) 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:57:20 INFO - Running setup.py (path:/tmp/pip-Deradg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:57:20 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)) 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:57:20 INFO - Running setup.py (path:/tmp/pip-keNq37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:57:20 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)) 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:57:20 INFO - Running setup.py (path:/tmp/pip-m5hsRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:57:20 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)) 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:57:20 INFO - Running setup.py (path:/tmp/pip-hHXAcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:57:20 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)) 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:57:20 INFO - Running setup.py (path:/tmp/pip-E454BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:57:20 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)) 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:57:20 INFO - Running setup.py (path:/tmp/pip-QZ5nT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:57:20 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)) 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:57:20 INFO - Running setup.py (path:/tmp/pip-730DlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:57:20 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)) 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:57:20 INFO - Running setup.py (path:/tmp/pip-MJ1bEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:57:20 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)) 19:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:57:20 INFO - Running setup.py (path:/tmp/pip-DacEOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:57:21 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)) 19:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:57:21 INFO - Running setup.py (path:/tmp/pip-rP_KJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:57:21 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)) 19:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:57:21 INFO - Running setup.py (path:/tmp/pip-AjaAcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:57:21 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)) 19:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:57:21 INFO - Running setup.py (path:/tmp/pip-7mNIdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:57:21 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)) 19:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:21 INFO - Running setup.py (path:/tmp/pip-Wb3wdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:21 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)) 19:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:57:21 INFO - Running setup.py (path:/tmp/pip-svjgWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:57:21 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)) 19:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:57:21 INFO - Running setup.py (path:/tmp/pip-EChgUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:57:21 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)) 19:57:21 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)) 19:57:21 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)) 19:57:21 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)) 19:57:21 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)) 19:57:21 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)) 19:57:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:57:21 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 19:57:21 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 19:57:21 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 19:57:21 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 19:57:21 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 19:57:21 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 19:57:23 INFO - Downloading blessings-1.6.tar.gz 19:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:57:23 INFO - Installing collected packages: blessings 19:57:23 INFO - Running setup.py install for blessings 19:57:23 INFO - Successfully installed blessings 19:57:23 INFO - Cleaning up... 19:57:23 INFO - Return code: 0 19:57:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:57:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:57:23 INFO - Reading from file tmpfile_stdout 19:57:23 INFO - Current package versions: 19:57:23 INFO - argparse == 1.2.1 19:57:23 INFO - blessings == 1.6 19:57:23 INFO - blobuploader == 1.2.4 19:57:23 INFO - docopt == 0.6.1 19:57:23 INFO - functools32 == 3.2.3-2 19:57:23 INFO - jsonschema == 2.5.1 19:57:23 INFO - manifestparser == 1.1 19:57:23 INFO - mozInstall == 1.12 19:57:23 INFO - mozcrash == 0.17 19:57:23 INFO - mozdebug == 0.1 19:57:23 INFO - mozdevice == 0.48 19:57:23 INFO - mozfile == 1.2 19:57:23 INFO - mozhttpd == 0.7 19:57:23 INFO - mozinfo == 0.9 19:57:23 INFO - mozleak == 0.1 19:57:23 INFO - mozlog == 3.3 19:57:23 INFO - moznetwork == 0.27 19:57:23 INFO - mozprocess == 0.23 19:57:23 INFO - mozprofile == 0.28 19:57:23 INFO - mozrunner == 6.12 19:57:23 INFO - mozscreenshot == 0.1 19:57:23 INFO - mozsystemmonitor == 0.3 19:57:23 INFO - moztest == 0.7 19:57:23 INFO - mozversion == 1.4 19:57:23 INFO - psutil == 3.1.1 19:57:23 INFO - requests == 1.2.3 19:57:23 INFO - wsgiref == 0.1.2 19:57:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:23 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, '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': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', '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 19:57:23 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 19:57:23 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 19:57:23 INFO - Using env: {'DISPLAY': ':0', 19:57:23 INFO - 'HOME': '/home/cltbld', 19:57:23 INFO - 'LANG': 'en_US.UTF-8', 19:57:23 INFO - 'LANGUAGE': 'en_US:en', 19:57:23 INFO - 'LOGNAME': 'cltbld', 19:57:23 INFO - 'MAIL': '/var/mail/cltbld', 19:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:23 INFO - 'MOZ_NO_REMOTE': '1', 19:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:23 INFO - 'NO_EM_RESTART': '1', 19:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:23 INFO - 'PWD': '/builds/slave/test', 19:57:23 INFO - 'SHELL': '/bin/bash', 19:57:23 INFO - 'SHLVL': '1', 19:57:23 INFO - 'TERM': 'linux', 19:57:23 INFO - 'TMOUT': '86400', 19:57:23 INFO - 'USER': 'cltbld', 19:57:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:23 INFO - '_': '/tools/buildbot/bin/python'} 19:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:23 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)) 19:57:23 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)) 19:57:23 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)) 19:57:23 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)) 19:57:23 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)) 19:57:23 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)) 19:57:23 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)) 19:57:23 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)) 19:57:23 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)) 19:57:23 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)) 19:57:23 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)) 19:57:23 INFO - Cleaning up... 19:57:24 INFO - Return code: 0 19:57:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:24 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, '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': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', '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 19:57:24 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 19:57:24 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 19:57:24 INFO - Using env: {'DISPLAY': ':0', 19:57:24 INFO - 'HOME': '/home/cltbld', 19:57:24 INFO - 'LANG': 'en_US.UTF-8', 19:57:24 INFO - 'LANGUAGE': 'en_US:en', 19:57:24 INFO - 'LOGNAME': 'cltbld', 19:57:24 INFO - 'MAIL': '/var/mail/cltbld', 19:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:24 INFO - 'MOZ_NO_REMOTE': '1', 19:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:24 INFO - 'NO_EM_RESTART': '1', 19:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:24 INFO - 'PWD': '/builds/slave/test', 19:57:24 INFO - 'SHELL': '/bin/bash', 19:57:24 INFO - 'SHLVL': '1', 19:57:24 INFO - 'TERM': 'linux', 19:57:24 INFO - 'TMOUT': '86400', 19:57:24 INFO - 'USER': 'cltbld', 19:57:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:24 INFO - '_': '/tools/buildbot/bin/python'} 19:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:57:24 INFO - Cleaning up... 19:57:24 INFO - Return code: 0 19:57:24 INFO - Running post-action listener: _resource_record_post_action 19:57:24 INFO - Running post-action listener: _start_resource_monitoring 19:57:24 INFO - Starting resource monitoring. 19:57:24 INFO - [mozharness: 2016-08-10 02:57:24.262411Z] Finished create-virtualenv step (success) 19:57:24 INFO - [mozharness: 2016-08-10 02:57:24.262882Z] Running install step. 19:57:24 INFO - Running pre-action listener: _resource_record_pre_action 19:57:24 INFO - Running main action method: install 19:57:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:57:24 INFO - Reading from file tmpfile_stdout 19:57:24 INFO - Detecting whether we're running mozinstall >=1.0... 19:57:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:57:24 INFO - Reading from file tmpfile_stdout 19:57:24 INFO - Output received: 19:57:24 INFO - Usage: mozinstall [options] installer 19:57:24 INFO - Options: 19:57:24 INFO - -h, --help show this help message and exit 19:57:24 INFO - -d DEST, --destination=DEST 19:57:24 INFO - Directory to install application into. [default: 19:57:24 INFO - "/builds/slave/test"] 19:57:24 INFO - --app=APP Application being installed. [default: firefox] 19:57:24 INFO - mkdir: /builds/slave/test/build/application 19:57:24 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'] 19:57:24 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 19:57:41 INFO - Reading from file tmpfile_stdout 19:57:41 INFO - Output received: 19:57:41 INFO - /builds/slave/test/build/application/firefox/firefox 19:57:41 INFO - Running post-action listener: _resource_record_post_action 19:57:41 INFO - [mozharness: 2016-08-10 02:57:41.840704Z] Finished install step (success) 19:57:41 INFO - [mozharness: 2016-08-10 02:57:41.840952Z] Running run-tests step. 19:57:41 INFO - Running pre-action listener: _resource_record_pre_action 19:57:41 INFO - Running main action method: run_tests 19:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:57:41 INFO - Python 2.7.3 19:57:41 INFO - Return code: 0 19:57:41 INFO - grabbing minidump binary from tooltool 19:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:41 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 0xe8d3b0>, '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 0xe8e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:57:41 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 19:57:41 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 19:57:41 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 19:57:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:57:41 INFO - Return code: 0 19:57:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:57:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:57:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:57:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:57:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 19:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 19:57:41 INFO - Using env: {'DISPLAY': ':0', 19:57:41 INFO - 'HOME': '/home/cltbld', 19:57:41 INFO - 'LANG': 'en_US.UTF-8', 19:57:41 INFO - 'LANGUAGE': 'en_US:en', 19:57:41 INFO - 'LOGNAME': 'cltbld', 19:57:41 INFO - 'MAIL': '/var/mail/cltbld', 19:57:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:57:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:41 INFO - 'MOZ_NO_REMOTE': '1', 19:57:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:41 INFO - 'NO_EM_RESTART': '1', 19:57:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:41 INFO - 'PWD': '/builds/slave/test', 19:57:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:57:41 INFO - 'SHELL': '/bin/bash', 19:57:41 INFO - 'SHLVL': '1', 19:57:41 INFO - 'TERM': 'linux', 19:57:41 INFO - 'TMOUT': '86400', 19:57:41 INFO - 'USER': 'cltbld', 19:57:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831', 19:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:41 INFO - '_': '/tools/buildbot/bin/python'} 19:57:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 19:57:42 INFO - mozversion application_buildid: 20160809173001 19:57:42 INFO - mozversion application_changeset: 13abad48dfb674a240bc019ab7c7305504f1eb93 19:57:42 INFO - mozversion application_display_name: Nightly 19:57:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:57:42 INFO - mozversion application_name: Firefox 19:57:42 INFO - mozversion application_remotingname: firefox 19:57:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:57:42 INFO - mozversion application_vendor: Mozilla 19:57:42 INFO - mozversion application_version: 51.0a1 19:57:42 INFO - mozversion platform_buildid: 20160809173001 19:57:42 INFO - mozversion platform_changeset: 13abad48dfb674a240bc019ab7c7305504f1eb93 19:57:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:57:42 INFO - mozversion platform_version: 51.0a1 19:57:42 INFO - using testdate: 1470797862 19:57:42 INFO - actual date: 1470797862 19:57:42 INFO - starting webserver on 'localhost:45274' 19:57:42 INFO - SUITE-START | Running 2 tests 19:57:42 INFO - TEST-START | dromaeo_css 19:57:42 INFO - operating with platform_type : linux_ 19:57:42 INFO - Initialising browser for dromaeo_css test... 19:57:42 INFO - TEST-INFO | started process 12812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7GGQV/profile http://localhost:45274/getInfo.html) 19:57:46 INFO - PROCESS | 12812 | __metrics Screen width/height:1600/1200 19:57:46 INFO - PROCESS | 12812 | colorDepth:24 19:57:46 INFO - PROCESS | 12812 | Browser inner width/height: 1024/697 19:57:46 INFO - PROCESS | 12812 | __metrics 19:57:46 INFO - PROCESS | 12812 | 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" 19:57:46 INFO - PROCESS | 12812 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:57:47 INFO - TEST-INFO | 12812: exit 0 19:57:47 INFO - Browser initialized. 19:57:47 INFO - Running cycle 1/1 for dromaeo_css test... 19:57:47 INFO - TEST-INFO | started process 12895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7GGQV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:59 INFO - PROCESS | 12895 | RSS: Main: 155906048 19:57:59 INFO - PROCESS | 12895 | 19:58:51 INFO - PROCESS | 12895 | 1470797931277 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] 20:01:00 INFO - PROCESS | 12895 | Cycle 1(1): loaded http://localhost:45274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45274/tests/dromaeo/cssquery-ext.html) 20:01:01 INFO - PROCESS | 12895 | RSS: Main: 257622016 20:01:01 INFO - PROCESS | 12895 | 20:04:04 INFO - PROCESS | 12895 | Cycle 1(1): loaded http://localhost:45274/tests/dromaeo/cssquery-ext.html (next: http://localhost:45274/tests/dromaeo/cssquery-jquery.html) 20:04:04 INFO - PROCESS | 12895 | RSS: Main: 241082368 20:04:04 INFO - PROCESS | 12895 | 20:07:06 INFO - PROCESS | 12895 | Cycle 1(1): loaded http://localhost:45274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45274/tests/dromaeo/cssquery-mootools.html) 20:07:07 INFO - PROCESS | 12895 | RSS: Main: 246333440 20:07:07 INFO - PROCESS | 12895 | 20:10:09 INFO - PROCESS | 12895 | Cycle 1(1): loaded http://localhost:45274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45274/tests/dromaeo/cssquery-prototype.html) 20:10:09 INFO - PROCESS | 12895 | RSS: Main: 237694976 20:10:09 INFO - PROCESS | 12895 | 20:13:12 INFO - PROCESS | 12895 | Cycle 1(1): loaded http://localhost:45274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45274/tests/dromaeo/cssquery-yui.html) 20:13:12 INFO - PROCESS | 12895 | RSS: Main: 186183680 20:13:12 INFO - PROCESS | 12895 | 20:16:15 INFO - PROCESS | 12895 | Cycle 1(1): loaded http://localhost:45274/tests/dromaeo/cssquery-yui.html (next: http://localhost:45274/tests/dromaeo/cssquery-dojo.html) 20:16:16 INFO - PROCESS | 12895 | RSS: Main: 274833408 20:16:16 INFO - PROCESS | 12895 | 20:16:16 INFO - PROCESS | 12895 | __start_tp_report 20:16:16 INFO - PROCESS | 12895 | _x_x_mozilla_page_load 20:16:16 INFO - PROCESS | 12895 | _x_x_mozilla_page_load_details 20:16:16 INFO - PROCESS | 12895 | |i|pagename|runs| 20:16:16 INFO - PROCESS | 12895 | |0;dojo.html;3018.4415883061633;3046.7714921380903;3069.8465076746156;3071.032624723212;3077;5164.070467315882;5231.686098834072;5252.1859111837675;5312.946870531298;5330.89338213236;5276.736163191835;5345.358556973159;5397.865053373667;5444.754986025629;5490.615656904019;4814.1334559779225;4845;4847.49101344359;4852.951470485303;5056.292119103328;4954.87612809679;4967.3542439483;4995.150824359849;5007.924881126786;5009.549140577347;4723.716577005373;4806.879828004293;4844.612431005511;4879.463259041502;4897.094037603055;4763.3093201485935;4766.118268120409;4775;4775.283707443877;4874.707517548923;4805.327254184417;4823.348847905558;4827.348307978448;4829.686070405448;4868.537488938545;5142.280080788692;5227.477252274742;5284.260203571503;5296.311479507678;5312.9734351328;5678.943210567924;5689.687067211302;5719.313682358102;5725.742341594639;5731.856703582402;5701.116326969326;5724.4561766632105;5730.713464326767;5741.79422321313;5756.913646295309;5105.872353191163;5274.525292723635;5302.443243459381;5334;5393.5954803389905;5837.678927658934;5888.381719919433;5896.027155519377;5896.7936122235515;5902.881942361215;5599.328080630269;5644.717764111778;5654.717264136777;5657;5664.915026274609;5493.560515158778;5569.777208911598;5624.437556244425;5625.493705566437;5711.514521265656;5639.2668953035845;5646.6894320811925;5648.5763567731765;5655.095184770417;5693;5614.63504872182;5658.971705141448;5663.122216056518;5665.235193248941;5672.319321681342;4225.72532785368;4310.051788606502;4310.374995625617;4359.324304732771;4361.760103194355;3876.496055512822;3925.0187453136714;3926.0381206604566;3927.7643341399607;3999.7000224983244;5428.185772134211;5434.021876062267;5435.619506634498;5483.150111732608;5485;5579.2746942897975;5801.593888427769;5802.79690210849;5811.912821307684;5814.476697097281;5292.179712144623;5315.176147697113;5329.600279978939;5344.786208551614;5408.567314614821;4905.435874874435;4914.311996320518;4914.606831453475;4917.262410638433;4920.950790492049;5776.653400795965;5895.64626122434;5954.315253745788;5958.225430693982;5958.344582095966;5699.971500142473;5746.741396637245;5756.683382414008;5791.420857914175;5843.766249350148;5971.790987315423;5996.310424301261;5997.790077347272;6000.249968753906;6001.609895356788;5432.619716619799;5672.829815105389;5679.6876171810945;5681.034224181982;5682.744276507649;5649.350324712546;5674;5705;5724.055530837365;5779.8555036124435;5513.696746678971;5581.079121944834;5587.469190426903;5589.077802162597;5592.105263157875;5370.62405631602;5574.108142697149;5576.721163941867;5587.161925711176;5591.440855914376;5416.404195538409;5472.835814925558;5519.2824932758485;5558.305211848519;5614.550835933197;5575.414581468887;5583.330000399978;5613.550915926634;5637.069883469182;5640.520555752807;5371.892562148657;5397.622166448311;5447.564194864481;5455.345358556999;5456.263404440349 20:16:16 INFO - PROCESS | 12895 | |1;ext.html;584.8420926349886;613.1171113596423;614.5390956782413;630.124127462827;644.4264604501991;32556.1860953476;33248.66751332486;35897.28205435896;35911;35980.82009589955;45542;46600.76699616505;46703.53296467035;51346.37882590566;51361.743191284084;9010.81978360434;9175.082491750838;9180.081991800833;9187.908120918772;9188.724338269829;9095.681651142211;9182.494962777044;9186.26509879208;9186.58660360282;9186.954065229664;9182.265418766483;9209.539523023856;9227.769305767342;9233.769155771091;9234.538273086353;9152.267818574532;9216.861747073799;9222.262219022463;9230.861537076915;9231.307651926132;9026.142516460992;9080.727578172666;9081.636734530612;9084.227840633554;9087.409318394282;44545.55454445446;44817.77591112056;44846.327305090446;44902.85680002401;44935.325970110476;3400.60892997306;3499.1077275294892;3564.590072141711;3590.910227244314;3693.538307711536;34421.655783442344;34748.65251347505;35067.649323506696;35487.82256088729;36075;3839.6733205145906;3840.865569705075;3898.142408670088;4020.517537895442;4023.3562629979065;345627;346960;348356;349939;350076;36036;61004.694976524836;61165.38834611686;61435.69282153561;61458;36757.26485470276;39004.80497597494;39200.41199382012;39354;39565.604343956766;15558.766618500731;15698;15708.842911570966;15721.449749258722;15724.371025159095;13106.934465327613;13247.403866826016;13344.266065366499;13362.599122026355;13364;8762.912370876336;8817.867731984026;8826.602802873886;8925.107489251022;8932.508712020901;3339.966600334014;3372.207531230159;3394.2362968331927;3459.498372735939;3460.913477163091;1049.186880167876;1052.02335173046;1060.2260349944584;1104.3925840787535;1126.4086354663702;34090.318193636485;34161.14597135092;34231.828840856135;34381.65618343835;35130;910.8269428808505;1096.9780604387868;1104.276698762312;1196.3778835005749;1209.1173443386376;16315.755263671055;17415.91292043557;17485.125743712764;17505;17553.98260021791;567233;568846;571005;571799;571838;60516.69741651264;61114.38885611087;61155.6942215295;61262.38737612656;61279;1274.095392271479;1286.292539103508;1323.6161513161076;1325.3770727757937;1352.8241328627216;30200.24499387533;34590;35205;35208.295834083685;35384;53627.73186134044;54000.729996349764;54209.457905422016;54221.45778542164;54317.72841135927;418001;420753;421072;421165;422435;29571.556426654046;30021;30156;30802.38395232038;32187.356252874342;50775.49224507855;51822.74088629533;51891;51936.740316299685;51976;42316.78841605772;42844;43110.78444607757;43664;45145;43149.78425107854;43807.780961096265;44564;44639.55360446354;44999.550004500845;38763;39892;39948;40141;40522;35272.82363588166;38036;38132.809335954254;38377.80811095927;39268.2146357077;29050.27374315659;29057.12828615145;29068.854655726587;29130.56304155397;29629.5555566671 20:16:16 INFO - PROCESS | 12895 | |2;jquery.html;378.2812655953686;392.85268024490796;401.12754758400473;405.2947870704973;414.5490782262083;13756.44974201032;17369.565760855985;19153.712694309597;19174.712379314322;19603.803961960377;18868.43394698158;19427.32004379847;19432.90283548584;19676.70484942727;19711.211551537923;5673.290838645169;5752.453516915886;5794.6523208607405;5887.558433117512;5888.352281249059;5614.101743720985;5685.829425117253;5736.512396446307;5738.31140263169;5763.452472015173;5554.638948468357;5762.3373312069225;5770.249867517216;5770.826875193751;5797.420257974211;5839.8540036499;5871.8532036699;5877.794277200299;5880.4119588041285;6214.533909956726;5691.459311365414;5844.444777746107;5853.151293062525;5857.47282744555;5862.472377486047;14162.36269367881;17252.48242552713;20156.395308140778;23005.654915176285;23130.7686923132;2246.8988895499742;2411.180198732422;2514.798816094708;2746.7115952824865;2797.9020734274404;9933.304668673196;10595.364278143259;10617.73455663607;11125.27685700435;14328.28358582077;1872.896990665513;1891.9716204256947;1902.7526421565246;1905.7046157845557;1973.4671638657626;81722.59138704329;85690.14309856883;86435;88724;88753;10795.29830561011;10974;10974.451277436096;11135.109191264679;11142.331460112257;15795.763063554055;15842.12868292255;15842.28709708066;15856.920715396349;15876.126813025163;8042.477238979448;8281.17188281167;8326.625301861432;8366;8516.190961858614;7723.768286951288;7836.921630783733;8015.438919275594;8109.270165685117;8126.634301456449;4746.691465054761;4843.2250839865455;4873.926891096637;4877.414710234794;4958.752062396938;1885.4720678210124;1987.6322880267196;2004;2012.5169959209977;2013.2550956146026;966.7631430299622;970.1753509516855;977.3354119199013;1038.963636272742;1073.1093192650083;18094.64290178242;18594;19582.31461898827;19614;19978.400647980583;914.7164379042518;947.924166066713;970.9223262139012;971.844504879216;978.6917121106828;10539.156867450585;10854.34873907568;10984.560617575367;11007.944960275308;11012.889871101186;550880.4207621333;554133;556887;574001;577716;85065.57467212624;95159;96062;100656.49671751594;100792;957.2533423929347;990.0990099009866;999.480270259461;1005.8038682456851;1009.6769033909079;16030.599235019217;16797.66404671924;16973.575660608585;17112.401065962633;18014.819851801316;43854.56145438633;43893.78053109714;44137;45002.77498612617;45296.320555191036;57560;61140.38859611525;62097;62511.6874415625;64322.35677643351;8581.669841174627;8759.562021898751;8845.69040083594;8869.955650221707;8897;10059.346142500714;13071.934640327117;13166.012549058667;13311.400986955416;13694.93152534231;11298.209125361145;11551.422428878355;11660.766784664089;11681.182317237712;11956.222845515014;11488.425578720864;11538.307701537935;11565.653030409101;11663.066954643438;12002.699932501408;11718.414079295831;11735.47190376418;11925;12023.27860328383;12029.037676985645;8618.956905215433;8652.134786521297;8677.349198809989;8732.56337183151;9005.684801031932;9603.759906002406;11317.320960742381;11340.432978351215;11395.601153959904;11731.7516883895 20:16:16 INFO - PROCESS | 12895 | |3;mootools.html;1344.4353371583934;1457.6938842843003;1530.3343045775089;1637.3450619752098;1757.8857374270663;8459.746207613774;8768.605412756426;8910.198082172603;9130.178283954443;9266.07339266073;9011.864822027675;9140.131687489678;9149;9152.130547597968;9152.588133533991;2338.7076615423116;2341.3678306857137;2363.3737059679197;2364.858108513486;2365.5860224460653;2335.8481698689616;2397.820163487737;2431.8540887546715;2436.049940523197;2436.8537887726793;2298.678185054094;2308.4575124845646;2351.5061837014164;2428.9757102428925;2433.6957880264968;2350.847194932324;2370.2652177824843;2377.6552399901916;2379.3456799380137;2380.5000949800565;2254.3124347074136;2278.703768510083;2279.282026161754;2280.1791355112146;2285.074544809355;8372.204640559137;9058.592363343665;9158.49628270445;9169;9183.49490778007;5306;5495.725213739337;5501.9174712379345;5502.697351645658;5506.531944784658;3617.6924961378313;3664.633536646341;3683.631636836322;3729.757565758217;3736.7384283100196;1192.8807119288;1200.789861774186;1215.6535387414544;1231.839860818097;1236.369451579692;12846;12851.678708032374;12863.935680321538;12876;12939.935300323532;4474.4048451897825;4652.55800698933;4838.371011768518;4838.975805120952;4850.466448690641;9953.651622193189;9996.050375214343;9996.50017499122;9997.55011024491;10000.24998125129;5405.351357837006;5417.6478528895495;5423.783048678088;5426.972865135649;5430.67415955044;3950.58518855516;4265.424167737316;4409.11817636474;4847.491013443609;5051.747412629354;3866.903327416837;3905.4727611772046;4004.5394779600138;4012.578679238696;4015.0765323975647;1133.6202372205403;1172.3903570143477;1174.2719513901266;1184.4492311075392;1184.7452797648548;872.289084396215;963.1620490173594;989.2827699917646;996.0487734213808;1025.29254814178;5898.705064746746;6036.275646922398;6090.908636370458;6099.420555047263;6150.108234306001;455.8769132334251;466.6360239013575;490.32527562148397;490.3894651159329;491.0326656486715;4164.979175104105;4206.158768246363;4251.489821221411;4287.442632457761;4304.332828411601;11164.218504704593;11373.886261137448;11518.827217591743;11521.193516453935;11541.942290288494;10650.520726567323;11132.833007504894;11144.721381965353;11443.313401195956;11460.54157833694;8386.161383861687;8576;8612.224899758927;8614.39699221061;8621.69824056155;6124.755009799558;6179.351168127282;6276.811695649138;6330.303666596578;6500.349965003651;10459.215558832966;10459.843102353623;10478.528466218886;10531.526081326205;10583.62957296491;10056.34633748804;10174.694759157237;10587.047165755119;10714.73213169677;10715.892841071802;7940.205979402013;8167.14245004266;8188.5905704715715;8189.918100818915;8194.180581941759;8664.436811607226;8735.301175905784;8878.556072196236;8942.955285223792;8954.776130596527;7941.8411631768195;7998.5600791957;8014.919850801417;8092.6762929482165;8279.130691277329;7846.058472983279;7915.762527124196;7919.722809701633;7961.960190199012;8025.879611805711;7070.222275549582;7104.325089116525;7181.605011724405;7201.603911784902;7204.24355442671;5028.515788009499;5238.030964271622;5240.633155679218;5271.367435907716;5289.069355822314;5408.648437851527;5461.890762184814;5514.228008078952;5587.7485513152815;5722 20:16:16 INFO - PROCESS | 12895 | |4;prototype.html;322.24112215731947;324.0909249554999;329.5106766451819;345.319720151302;349.56479183416616;5006.649534532584;5160;5197.402298735647;5220.399654039787;5226.346706661668;5181.922271165936;5197.8440646780655;5198.844034678957;5199.558037566811;5205.687658740479;4151.46031015969;4156.251874662559;4158.230727315448;4161.4382058422025;4163.084980908786;4017.718759686823;4029.597040295976;4104.610062044101;4118.876433706993;4170.332746760519;4039.293123703355;4044.1488750430876;4049.4533238012787;4062.2890994076065;4064.97967510162;4067.2068946555432;4070.124923141524;4071.165411090749;4077.3476243800997;4080.2451546463703;3663;3686.7972261525606;3688.723345749053;3696.722745794076;3696.9260614787822;4917.827876024322;5077.619178561586;5099.668521546125;5100.566451851597;5108.770105345231;4702.717836929795;4720.858374248778;4728.881777955544;4729.196036673774;4729.55069268419;5262.342207224097;5430.891382172374;5435.804123092913;5450.945490545084;5452.473307473913;4005.3190957537;4016.9598304016877;4024.7383920045104;4037.9097643636055;4039.232545816315;5360.463953604647;5366.141417373202;5641.943580564182;5643.7460314285545;5649.389923871677;4044.3933409988736;4051.913264668698;4052.392141178788;4053.169100334483;4060.553339132693;4084.345839934831;4087.3460246361033;4097.774622395737;4104.610062044101;4105.2405305018665;4453;4613.677042606985;4631.564215093332;4632.698874573142;4633.166030114612;5385.6230063895155;5398.24424580559;5413.188021796684;5413.621046526784;5415.891682166334;1396.7010680067635;1409.3516982188103;1409.7391982483273;1417.4046900301898;1418.0569921002418;869.2481003931554;918.7703074231442;935.5930170375908;938.8779458670466;943.4339396362128;4563.931541026887;4581.885452863705;4588.541145885385;4592.448906131285;4599.2871104978785;4805.27920811881;4839.2983017462275;4894.458245652608;4928;4934.55588996992;4412.779361031936;4508.864734057984;4538.841140560065;4622.2835460503675;4638.744869032168;2569.7044839843284;2586.689597248342;2587.469568738404;2589.6503971963543;2601.648777415063;5002.399712034579;5009.774560144802;5010.574101201366;5018.824341148043;5028.466317773041;4753;4939.653664509329;4946.629002824802;4966.304717339575;4972.975135124301;4970.254461830755;4979.228219625964;4987.177115775857;5009.624278179078;5010.624203184776;4765.666403351732;4815.242436510718;4827.42070951488;4830.613550915848;4834.782434790513;4527.750973696347;4773.689710168828;4778.856634300976;4805.414213309529;4825.6139508839915;4990.600751939909;5014;5493;5615.410381910004;5738.626989245686;4090.284200264882;4106;4107.527634322091;4112.91774164509;4116.876493705194;5568.916466252928;5571.857769157232;5578.63738856973;5585.441455854382;5589.888202236014;5222.206119725928;5468.2344471773185;5472.042392581203;5474.671519708831;5489.780408783604;5416.697903391122;5446.645968012067;5451.936872309861;5465.890682186414;5476.424975377528;5212.921806172986;5402.378726446509;5415.673160075807;5416.783328666967;5427.077396842467;5433.157860531624;5481.862953426196;5496.780128794963;5509.724513774215;5522.779088836563;5370.758315875873;5376.198973343973;5377.112776392008;5388.164834450667;5413.941123265343 20:16:16 INFO - PROCESS | 12895 | |5;yui.html;713.9892901606477;744.2445917393843;755.9130699969505;794.9602519874006;854.0562678240548;16077.51767446977;16731.414400495985;16760.916195419035;16766.413175538873;16777.32890684371;15397;15520.456784012562;15590.766138507932;15602.297896594651;15603.765943510827;669.2972379002052;807.2008711375754;818.3698552114882;829.0258945738763;832.950022998622;816.2082779703708;820.5938060659981;822.1613953767154;822.8189798244376;823.8928939237891;871.4640496094888;871.9433236839585;872.8297981893534;872.9956350218272;873.0701802580263;707.6178863413802;847.6355167278068;870.4951128345544;870.6865528409768;871.1549796697194;631.0880777276836;631.5421319543341;632.0645444741808;632.4782054804758;634.552640388525;14016.85983140176;14054.086484378482;14070.22613756243;14077.577672669837;14095.859041409558;13781.724365512633;14015.956261421179;14344.64138396538;14913.92543037278;15115.848841511553;13279.867201328056;13390.196588204739;13531.32343382827;13559.661008474768;13689.247091409969;4343.478782546114;4388.890277743082;4399.780010999437;4445;4477.1493416250805;63766;65074;66033;80354.99999999942;81587.59206203932;11677.649670509898;11726.589569365031;11818.940905295418;11972.940135299268;12206.206596571194;19729.210831566576;19744.40766776999;19792.109355079057;19829.206831726857;19852.503687407643;9043.095690430904;9083.318751093562;9100.499472528942;9112.362134650644;9437.197838183694;4946.431160416526;4960.751962401938;4988.55103040728;5015.197568389113;5145.974270128625;3553.680168784822;3666.4866918631415;3696.8890933272046;3696.9815150924073;3698.815059247027;600.4115966352998;601.3685630088389;603.4491357212011;608.5131894484394;620.8137558732362;670.5373292428209;699.349604867468;730.4047201530735;766.3218052023999;788.1094363369356;9906.900930990741;10247.077763001365;10513.52689128991;10546.209034322457;10667.359958402521;747.4905319524779;752.762879692895;756.1644382956863;771.1709911844789;774.5120574038432;4634.582887540138;5006.599472042228;5035.697858128524;5058.822941197114;5061.974690126526;75217;97002;127043;132832.3358383202;133601;63164.105076847765;96505;104412.47793761134;104937.47531262295;106236;82417.58791206125;84133.57933210417;84614.57692711498;86929.13070869337;88766.55616721875;9913.256505761952;10204;10353;10420.47897605132;10470.267081304235;48070.27894581654;49675.25487117768;50198.74900625474;51290.48709513006;52166.47833521616;71867.64066179635;73420.29086945794;77678;78218.6089069551;79123;13350;13424.39590218423;13599.59201223965;13716.245606491739;14388.928055359656;15283.769009044738;15748.370065197263;15936.442224522087;16116.355345786038;16412.507624771275;14267.49688667497;15020.849791501945;15140.091594503925;15369.231538422811;15507.844921551092;13561.932190338985;13887.861121388656;14244.857551424353;14411.92794036023;14892.473653308458;13725.794113088112;13896.58310250694;14105.576832695035;14216.573502794932;14541.27293635335;11679.766404671689;11885.34630595291;12108.394580270775;12145.939270303592;12254;10918.727031824268;11024.516643412142;11369.772604548029;12205.267683938991;12639.620811375673 20:16:16 INFO - PROCESS | 12895 | __end_tp_report 20:16:16 INFO - PROCESS | 12895 | __start_cc_report 20:16:16 INFO - PROCESS | 12895 | _x_x_mozilla_cycle_collect,995 20:16:16 INFO - PROCESS | 12895 | __end_cc_report 20:16:16 INFO - PROCESS | 12895 | __startTimestamp1470798976218__endTimestamp 20:16:16 INFO - PROCESS | 12895 | 20:16:16 INFO - PROCESS | 12895 | ------- Summary: start ------- 20:16:16 INFO - PROCESS | 12895 | Number of tests: 6 20:16:16 INFO - PROCESS | 12895 | 20:16:16 INFO - PROCESS | 12895 | [#0] dojo.html Cycles:165 Average:5297.91 Median:5485.00 stddev:608.33 (11.1%) stddev-sans-first:583.32 20:16:16 INFO - PROCESS | 12895 | Values: 3018.4 3046.8 3069.8 3071.0 3077.0 5164.1 5231.7 5252.2 5312.9 5330.9 5276.7 5345.4 5397.9 5444.8 5490.6 4814.1 4845.0 4847.5 4853.0 5056.3 4954.9 4967.4 4995.2 5007.9 5009.5 4723.7 4806.9 4844.6 4879.5 4897.1 4763.3 4766.1 4775.0 4775.3 4874.7 4805.3 4823.3 4827.3 4829.7 4868.5 5142.3 5227.5 5284.3 5296.3 5313.0 5678.9 5689.7 5719.3 5725.7 5731.9 5701.1 5724.5 5730.7 5741.8 5756.9 5105.9 5274.5 5302.4 5334.0 5393.6 5837.7 5888.4 5896.0 5896.8 5902.9 5599.3 5644.7 5654.7 5657.0 5664.9 5493.6 5569.8 5624.4 5625.5 5711.5 5639.3 5646.7 5648.6 5655.1 5693.0 5614.6 5659.0 5663.1 5665.2 5672.3 4225.7 4310.1 4310.4 4359.3 4361.8 3876.5 3925.0 3926.0 3927.8 3999.7 5428.2 5434.0 5435.6 5483.2 5485.0 5579.3 5801.6 5802.8 5811.9 5814.5 5292.2 5315.2 5329.6 5344.8 5408.6 4905.4 4914.3 4914.6 4917.3 4921.0 5776.7 5895.6 5954.3 5958.2 5958.3 5700.0 5746.7 5756.7 5791.4 5843.8 5971.8 5996.3 5997.8 6000.2 6001.6 5432.6 5672.8 5679.7 5681.0 5682.7 5649.4 5674.0 5705.0 5724.1 5779.9 5513.7 5581.1 5587.5 5589.1 5592.1 5370.6 5574.1 5576.7 5587.2 5591.4 5416.4 5472.8 5519.3 5558.3 5614.6 5575.4 5583.3 5613.6 5637.1 5640.5 5371.9 5397.6 5447.6 5455.3 5456.3 20:16:16 INFO - PROCESS | 12895 | 20:16:16 INFO - PROCESS | 12895 | [#1] ext.html Cycles:180 Average:60369.22 Median:40044.50 stddev:121125.28 (302.5%) stddev-sans-first:121381.89 20:16:16 INFO - PROCESS | 12895 | Values: 584.8 613.1 614.5 630.1 644.4 32556.2 33248.7 35897.3 35911.0 35980.8 45542.0 46600.8 46703.5 51346.4 51361.7 9010.8 9175.1 9180.1 9187.9 9188.7 9095.7 9182.5 9186.3 9186.6 9187.0 9182.3 9209.5 9227.8 9233.8 9234.5 9152.3 9216.9 9222.3 9230.9 9231.3 9026.1 9080.7 9081.6 9084.2 9087.4 44545.6 44817.8 44846.3 44902.9 44935.3 3400.6 3499.1 3564.6 3590.9 3693.5 34421.7 34748.7 35067.6 35487.8 36075.0 3839.7 3840.9 3898.1 4020.5 4023.4 345627.0 346960.0 348356.0 349939.0 350076.0 36036.0 61004.7 61165.4 61435.7 61458.0 36757.3 39004.8 39200.4 39354.0 39565.6 15558.8 15698.0 15708.8 15721.4 15724.4 13106.9 13247.4 13344.3 13362.6 13364.0 8762.9 8817.9 8826.6 8925.1 8932.5 3340.0 3372.2 3394.2 3459.5 3460.9 1049.2 1052.0 1060.2 1104.4 1126.4 34090.3 34161.1 34231.8 34381.7 35130.0 910.8 1097.0 1104.3 1196.4 1209.1 16315.8 17415.9 17485.1 17505.0 17554.0 567233.0 568846.0 571005.0 571799.0 571838.0 60516.7 61114.4 61155.7 61262.4 61279.0 1274.1 1286.3 1323.6 1325.4 1352.8 30200.2 34590.0 35205.0 35208.3 35384.0 53627.7 54000.7 54209.5 54221.5 54317.7 418001.0 420753.0 421072.0 421165.0 422435.0 29571.6 30021.0 30156.0 30802.4 32187.4 50775.5 51822.7 51891.0 51936.7 51976.0 42316.8 42844.0 43110.8 43664.0 45145.0 43149.8 43807.8 44564.0 44639.6 44999.6 38763.0 39892.0 39948.0 40141.0 40522.0 35272.8 38036.0 38132.8 38377.8 39268.2 29050.3 29057.1 29068.9 29130.6 29629.6 20:16:16 INFO - PROCESS | 12895 | 20:16:16 INFO - PROCESS | 12895 | [#2] jquery.html Cycles:180 Average:31356.29 Median:396.99 stddev:92652.06 (23338.6%) stddev-sans-first:92882.77 20:16:16 INFO - PROCESS | 12895 | Values: 378.3 392.9 401.1 405.3 414.5 13756.4 17369.6 19153.7 19174.7 19603.8 18868.4 19427.3 19432.9 19676.7 19711.2 5673.3 5752.5 5794.7 5887.6 5888.4 5614.1 5685.8 5736.5 5738.3 5763.5 5554.6 5762.3 5770.2 5770.8 5797.4 5839.9 5871.9 5877.8 5880.4 6214.5 5691.5 5844.4 5853.2 5857.5 5862.5 14162.4 17252.5 20156.4 23005.7 23130.8 2246.9 2411.2 2514.8 2746.7 2797.9 9933.3 10595.4 10617.7 11125.3 14328.3 1872.9 1892.0 1902.8 1905.7 1973.5 81722.6 85690.1 86435.0 88724.0 88753.0 10795.3 10974.0 10974.5 11135.1 11142.3 15795.8 15842.1 15842.3 15856.9 15876.1 8042.5 8281.2 8326.6 8366.0 8516.2 7723.8 7836.9 8015.4 8109.3 8126.6 4746.7 4843.2 4873.9 4877.4 4958.8 1885.5 1987.6 2004.0 2012.5 2013.3 966.8 970.2 977.3 1039.0 1073.1 18094.6 18594.0 19582.3 19614.0 19978.4 914.7 947.9 970.9 971.8 978.7 10539.2 10854.3 10984.6 11007.9 11012.9 550880.4 554133.0 556887.0 574001.0 577716.0 85065.6 95159.0 96062.0 100656.5 100792.0 957.3 990.1 999.5 1005.8 1009.7 16030.6 16797.7 16973.6 17112.4 18014.8 43854.6 43893.8 44137.0 45002.8 45296.3 57560.0 61140.4 62097.0 62511.7 64322.4 8581.7 8759.6 8845.7 8870.0 8897.0 10059.3 13071.9 13166.0 13311.4 13694.9 11298.2 11551.4 11660.8 11681.2 11956.2 11488.4 11538.3 11565.7 11663.1 12002.7 11718.4 11735.5 11925.0 12023.3 12029.0 8619.0 8652.1 8677.3 8732.6 9005.7 9603.8 11317.3 11340.4 11395.6 11731.8 20:16:16 INFO - PROCESS | 12895 | 20:16:16 INFO - PROCESS | 12895 | [#3] mootools.html Cycles:180 Average:5954.47 Median:4843.23 stddev:3432.86 (70.9%) stddev-sans-first:3425.01 20:16:16 INFO - PROCESS | 12895 | Values: 1344.4 1457.7 1530.3 1637.3 1757.9 8459.7 8768.6 8910.2 9130.2 9266.1 9011.9 9140.1 9149.0 9152.1 9152.6 2338.7 2341.4 2363.4 2364.9 2365.6 2335.8 2397.8 2431.9 2436.0 2436.9 2298.7 2308.5 2351.5 2429.0 2433.7 2350.8 2370.3 2377.7 2379.3 2380.5 2254.3 2278.7 2279.3 2280.2 2285.1 8372.2 9058.6 9158.5 9169.0 9183.5 5306.0 5495.7 5501.9 5502.7 5506.5 3617.7 3664.6 3683.6 3729.8 3736.7 1192.9 1200.8 1215.7 1231.8 1236.4 12846.0 12851.7 12863.9 12876.0 12939.9 4474.4 4652.6 4838.4 4839.0 4850.5 9953.7 9996.1 9996.5 9997.6 10000.2 5405.4 5417.6 5423.8 5427.0 5430.7 3950.6 4265.4 4409.1 4847.5 5051.7 3866.9 3905.5 4004.5 4012.6 4015.1 1133.6 1172.4 1174.3 1184.4 1184.7 872.3 963.2 989.3 996.0 1025.3 5898.7 6036.3 6090.9 6099.4 6150.1 455.9 466.6 490.3 490.4 491.0 4165.0 4206.2 4251.5 4287.4 4304.3 11164.2 11373.9 11518.8 11521.2 11541.9 10650.5 11132.8 11144.7 11443.3 11460.5 8386.2 8576.0 8612.2 8614.4 8621.7 6124.8 6179.4 6276.8 6330.3 6500.3 10459.2 10459.8 10478.5 10531.5 10583.6 10056.3 10174.7 10587.0 10714.7 10715.9 7940.2 8167.1 8188.6 8189.9 8194.2 8664.4 8735.3 8878.6 8943.0 8954.8 7941.8 7998.6 8014.9 8092.7 8279.1 7846.1 7915.8 7919.7 7962.0 8025.9 7070.2 7104.3 7181.6 7201.6 7204.2 5028.5 5238.0 5240.6 5271.4 5289.1 5408.6 5461.9 5514.2 5587.7 5722.0 20:16:16 INFO - PROCESS | 12895 | 20:16:16 INFO - PROCESS | 12895 | [#4] prototype.html Cycles:180 Average:4423.13 Median:4832.70 stddev:1257.66 (26.0%) stddev-sans-first:1222.94 20:16:16 INFO - PROCESS | 12895 | Values: 322.2 324.1 329.5 345.3 349.6 5006.6 5160.0 5197.4 5220.4 5226.3 5181.9 5197.8 5198.8 5199.6 5205.7 4151.5 4156.3 4158.2 4161.4 4163.1 4017.7 4029.6 4104.6 4118.9 4170.3 4039.3 4044.1 4049.5 4062.3 4065.0 4067.2 4070.1 4071.2 4077.3 4080.2 3663.0 3686.8 3688.7 3696.7 3696.9 4917.8 5077.6 5099.7 5100.6 5108.8 4702.7 4720.9 4728.9 4729.2 4729.6 5262.3 5430.9 5435.8 5450.9 5452.5 4005.3 4017.0 4024.7 4037.9 4039.2 5360.5 5366.1 5641.9 5643.7 5649.4 4044.4 4051.9 4052.4 4053.2 4060.6 4084.3 4087.3 4097.8 4104.6 4105.2 4453.0 4613.7 4631.6 4632.7 4633.2 5385.6 5398.2 5413.2 5413.6 5415.9 1396.7 1409.4 1409.7 1417.4 1418.1 869.2 918.8 935.6 938.9 943.4 4563.9 4581.9 4588.5 4592.4 4599.3 4805.3 4839.3 4894.5 4928.0 4934.6 4412.8 4508.9 4538.8 4622.3 4638.7 2569.7 2586.7 2587.5 2589.7 2601.6 5002.4 5009.8 5010.6 5018.8 5028.5 4753.0 4939.7 4946.6 4966.3 4973.0 4970.3 4979.2 4987.2 5009.6 5010.6 4765.7 4815.2 4827.4 4830.6 4834.8 4527.8 4773.7 4778.9 4805.4 4825.6 4990.6 5014.0 5493.0 5615.4 5738.6 4090.3 4106.0 4107.5 4112.9 4116.9 5568.9 5571.9 5578.6 5585.4 5589.9 5222.2 5468.2 5472.0 5474.7 5489.8 5416.7 5446.6 5451.9 5465.9 5476.4 5212.9 5402.4 5415.7 5416.8 5427.1 5433.2 5481.9 5496.8 5509.7 5522.8 5370.8 5376.2 5377.1 5388.2 5413.9 20:16:16 INFO - PROCESS | 12895 | 20:16:16 INFO - PROCESS | 12895 | [#5] yui.html Cycles:180 Average:20787.77 Median:4394.34 stddev:29534.82 (672.1%) stddev-sans-first:29579.22 20:16:16 INFO - PROCESS | 12895 | Values: 714.0 744.2 755.9 795.0 854.1 16077.5 16731.4 16760.9 16766.4 16777.3 15397.0 15520.5 15590.8 15602.3 15603.8 669.3 807.2 818.4 829.0 833.0 816.2 820.6 822.2 822.8 823.9 871.5 871.9 872.8 873.0 873.1 707.6 847.6 870.5 870.7 871.2 631.1 631.5 632.1 632.5 634.6 14016.9 14054.1 14070.2 14077.6 14095.9 13781.7 14016.0 14344.6 14913.9 15115.8 13279.9 13390.2 13531.3 13559.7 13689.2 4343.5 4388.9 4399.8 4445.0 4477.1 63766.0 65074.0 66033.0 80355.0 81587.6 11677.6 11726.6 11818.9 11972.9 12206.2 19729.2 19744.4 19792.1 19829.2 19852.5 9043.1 9083.3 9100.5 9112.4 9437.2 4946.4 4960.8 4988.6 5015.2 5146.0 3553.7 3666.5 3696.9 3697.0 3698.8 600.4 601.4 603.4 608.5 620.8 670.5 699.3 730.4 766.3 788.1 9906.9 10247.1 10513.5 10546.2 10667.4 747.5 752.8 756.2 771.2 774.5 4634.6 5006.6 5035.7 5058.8 5062.0 75217.0 97002.0 127043.0 132832.3 133601.0 63164.1 96505.0 104412.5 104937.5 106236.0 82417.6 84133.6 84614.6 86929.1 88766.6 9913.3 10204.0 10353.0 10420.5 10470.3 48070.3 49675.3 50198.7 51290.5 52166.5 71867.6 73420.3 77678.0 78218.6 79123.0 13350.0 13424.4 13599.6 13716.2 14388.9 15283.8 15748.4 15936.4 16116.4 16412.5 14267.5 15020.8 15140.1 15369.2 15507.8 13561.9 13887.9 14244.9 14411.9 14892.5 13725.8 13896.6 14105.6 14216.6 14541.3 11679.8 11885.3 12108.4 12145.9 12254.0 10918.7 11024.5 11369.8 12205.3 12639.6 20:16:16 INFO - PROCESS | 12895 | -------- Summary: end -------- 20:16:16 INFO - PROCESS | 12895 | 20:16:17 INFO - TEST-INFO | 12895: exit 0 20:16:17 INFO - TEST-OK | dromaeo_css | took 1114938ms 20:16:17 INFO - TEST-START | kraken 20:16:17 INFO - operating with platform_type : linux_ 20:16:17 INFO - Initialising browser for kraken test... 20:16:17 INFO - TEST-INFO | started process 13087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv5AcGd/profile http://localhost:45274/getInfo.html) 20:16:20 INFO - PROCESS | 13087 | __metrics Screen width/height:1600/1200 20:16:20 INFO - PROCESS | 13087 | colorDepth:24 20:16:20 INFO - PROCESS | 13087 | Browser inner width/height: 1024/697 20:16:20 INFO - PROCESS | 13087 | __metrics 20:16:21 INFO - PROCESS | 13087 | 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" 20:16:21 INFO - PROCESS | 13087 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:16:22 INFO - PROCESS | 13087 | console.error: PushService: 20:16:22 INFO - PROCESS | 13087 | stateChangeProcessEnqueue: Error transitioning state 20:16:22 INFO - PROCESS | 13087 | UnknownError 20:16:22 INFO - TEST-INFO | 13087: exit 0 20:16:22 INFO - Browser initialized. 20:16:22 INFO - Running cycle 1/1 for kraken test... 20:16:22 INFO - TEST-INFO | started process 13171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv5AcGd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:34 INFO - PROCESS | 13171 | RSS: Main: 155553792 20:16:34 INFO - PROCESS | 13171 | 20:16:37 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45274/tests/kraken/driver.html?testName=audio-beat-detection) 20:16:37 INFO - PROCESS | 13171 | RSS: Main: 211722240 20:16:37 INFO - PROCESS | 13171 | 20:16:40 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45274/tests/kraken/driver.html?testName=audio-dft) 20:16:41 INFO - PROCESS | 13171 | RSS: Main: 190836736 20:16:41 INFO - PROCESS | 13171 | 20:16:44 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45274/tests/kraken/driver.html?testName=audio-fft) 20:16:44 INFO - PROCESS | 13171 | RSS: Main: 269000704 20:16:44 INFO - PROCESS | 13171 | 20:16:46 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45274/tests/kraken/driver.html?testName=audio-oscillator) 20:16:47 INFO - PROCESS | 13171 | RSS: Main: 178130944 20:16:47 INFO - PROCESS | 13171 | 20:16:49 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:16:50 INFO - PROCESS | 13171 | RSS: Main: 183373824 20:16:50 INFO - PROCESS | 13171 | 20:16:53 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45274/tests/kraken/driver.html?testName=imaging-darkroom) 20:16:53 INFO - PROCESS | 13171 | RSS: Main: 218198016 20:16:53 INFO - PROCESS | 13171 | 20:16:57 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45274/tests/kraken/driver.html?testName=imaging-desaturate) 20:16:57 INFO - PROCESS | 13171 | RSS: Main: 219217920 20:16:57 INFO - PROCESS | 13171 | 20:17:00 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45274/tests/kraken/driver.html?testName=json-parse-financial) 20:17:01 INFO - PROCESS | 13171 | RSS: Main: 218890240 20:17:01 INFO - PROCESS | 13171 | 20:17:02 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:17:03 INFO - PROCESS | 13171 | RSS: Main: 182882304 20:17:03 INFO - PROCESS | 13171 | 20:17:05 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45274/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:17:05 INFO - PROCESS | 13171 | RSS: Main: 189575168 20:17:05 INFO - PROCESS | 13171 | 20:17:07 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:17:08 INFO - PROCESS | 13171 | RSS: Main: 193204224 20:17:08 INFO - PROCESS | 13171 | 20:17:10 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:17:11 INFO - PROCESS | 13171 | RSS: Main: 186355712 20:17:11 INFO - PROCESS | 13171 | 20:17:14 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:17:14 INFO - PROCESS | 13171 | RSS: Main: 191172608 20:17:14 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:45274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45274/tests/kraken/driver.html?testName=ai-astar) 20:17:16 INFO - PROCESS | 13171 | RSS: Main: 241864704 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | __start_tp_report 20:17:16 INFO - PROCESS | 13171 | _x_x_mozilla_page_load 20:17:16 INFO - PROCESS | 13171 | _x_x_mozilla_page_load_details 20:17:16 INFO - PROCESS | 13171 | |i|pagename|runs| 20:17:16 INFO - PROCESS | 13171 | |0;ai-astar;103;111;112;112;112;112;111;111;110;111 20:17:16 INFO - PROCESS | 13171 | |1;audio-beat-detection;151;123;122;172;122;117;142;120;165;117 20:17:16 INFO - PROCESS | 13171 | |2;audio-dft;161;161;160;159;158;159;159;160;161;161 20:17:16 INFO - PROCESS | 13171 | |3;audio-fft;74;75;74;108;75;76;75;75;98;74 20:17:16 INFO - PROCESS | 13171 | |4;audio-oscillator;83;83;131;84;84;84;118;85;84;123 20:17:16 INFO - PROCESS | 13171 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;117;116;116 20:17:16 INFO - PROCESS | 13171 | |6;imaging-darkroom;146;145;146;145;146;145;146;146;145;146 20:17:16 INFO - PROCESS | 13171 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;95 20:17:16 INFO - PROCESS | 13171 | |8;json-parse-financial;63;51;49;50;51;50;53;50;51;51 20:17:16 INFO - PROCESS | 13171 | |9;json-stringify-tinderbox;60;62;61;61;62;61;62;61;61;62 20:17:16 INFO - PROCESS | 13171 | |10;stanford-crypto-aes;89;76;76;76;76;77;76;77;75;81 20:17:16 INFO - PROCESS | 13171 | |11;stanford-crypto-ccm;123;121;120;121;122;119;121;118;145;123 20:17:16 INFO - PROCESS | 13171 | |12;stanford-crypto-pbkdf2;157;158;161;160;161;162;160;160;161;163 20:17:16 INFO - PROCESS | 13171 | |13;stanford-crypto-sha256-iterative;63;66;63;63;63;63;62;63;64;62 20:17:16 INFO - PROCESS | 13171 | __end_tp_report 20:17:16 INFO - PROCESS | 13171 | __start_cc_report 20:17:16 INFO - PROCESS | 13171 | _x_x_mozilla_cycle_collect,1671 20:17:16 INFO - PROCESS | 13171 | __end_cc_report 20:17:16 INFO - PROCESS | 13171 | __startTimestamp1470799036730__endTimestamp 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | ------- Summary: start ------- 20:17:16 INFO - PROCESS | 13171 | Number of tests: 14 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.72 (2.4%) stddev-sans-first:0.71 20:17:16 INFO - PROCESS | 13171 | Values: 103.0 111.0 112.0 112.0 112.0 112.0 111.0 111.0 110.0 111.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:132.50 stddev:20.89 (15.8%) stddev-sans-first:21.35 20:17:16 INFO - PROCESS | 13171 | Values: 151.0 123.0 122.0 172.0 122.0 117.0 142.0 120.0 165.0 117.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 20:17:16 INFO - PROCESS | 13171 | Values: 161.0 161.0 160.0 159.0 158.0 159.0 159.0 160.0 161.0 161.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:12.16 (16.2%) stddev-sans-first:12.67 20:17:16 INFO - PROCESS | 13171 | Values: 74.0 75.0 74.0 108.0 75.0 76.0 75.0 75.0 98.0 74.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:84.00 stddev:19.64 (23.4%) stddev-sans-first:20.27 20:17:16 INFO - PROCESS | 13171 | Values: 83.0 83.0 131.0 84.0 84.0 84.0 118.0 85.0 84.0 123.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:17:16 INFO - PROCESS | 13171 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:17:16 INFO - PROCESS | 13171 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:17:16 INFO - PROCESS | 13171 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:51.00 stddev:4.04 (7.9%) stddev-sans-first:1.12 20:17:16 INFO - PROCESS | 13171 | Values: 63.0 51.0 49.0 50.0 51.0 50.0 53.0 50.0 51.0 51.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.53 20:17:16 INFO - PROCESS | 13171 | Values: 60.0 62.0 61.0 61.0 62.0 61.0 62.0 61.0 61.0 62.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:76.50 stddev:4.23 (5.5%) stddev-sans-first:1.73 20:17:16 INFO - PROCESS | 13171 | Values: 89.0 76.0 76.0 76.0 76.0 77.0 76.0 77.0 75.0 81.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:121.50 stddev:7.79 (6.4%) stddev-sans-first:8.26 20:17:16 INFO - PROCESS | 13171 | Values: 123.0 121.0 120.0 121.0 122.0 119.0 121.0 118.0 145.0 123.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.00 stddev:1.77 (1.1%) stddev-sans-first:1.41 20:17:16 INFO - PROCESS | 13171 | Values: 157.0 158.0 161.0 160.0 161.0 162.0 160.0 160.0 161.0 163.0 20:17:16 INFO - PROCESS | 13171 | 20:17:16 INFO - PROCESS | 13171 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 20:17:16 INFO - PROCESS | 13171 | Values: 63.0 66.0 63.0 63.0 63.0 63.0 62.0 63.0 64.0 62.0 20:17:16 INFO - PROCESS | 13171 | -------- Summary: end -------- 20:17:16 INFO - PROCESS | 13171 | 20:17:17 INFO - TEST-INFO | 13171: exit 0 20:17:17 INFO - TEST-OK | kraken | took 60635ms 20:17:17 INFO - SUITE-END | took 1175s 20:17:17 INFO - Completed test suite (00:19:35) 20:17:17 INFO - javascript benchmark 20:17:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3018.4415883061633, 3046.7714921380903, 3069.8465076746156, 3071.032624723212, 3077.0, 5164.070467315882, 5231.686098834072, 5252.1859111837675, 5312.946870531298, 5330.89338213236, 5276.736163191835, 5345.358556973159, 5397.865053373667, 5444.754986025629, 5490.615656904019, 4814.1334559779225, 4845.0, 4847.49101344359, 4852.951470485303, 5056.292119103328, 4954.87612809679, 4967.3542439483, 4995.150824359849, 5007.924881126786, 5009.549140577347, 4723.716577005373, 4806.879828004293, 4844.612431005511, 4879.463259041502, 4897.094037603055, 4763.3093201485935, 4766.118268120409, 4775.0, 4775.283707443877, 4874.707517548923, 4805.327254184417, 4823.348847905558, 4827.348307978448, 4829.686070405448, 4868.537488938545, 5142.280080788692, 5227.477252274742, 5284.260203571503, 5296.311479507678, 5312.9734351328, 5678.943210567924, 5689.687067211302, 5719.313682358102, 5725.742341594639, 5731.856703582402, 5701.116326969326, 5724.4561766632105, 5730.713464326767, 5741.79422321313, 5756.913646295309, 5105.872353191163, 5274.525292723635, 5302.443243459381, 5334.0, 5393.5954803389905, 5837.678927658934, 5888.381719919433, 5896.027155519377, 5896.7936122235515, 5902.881942361215, 5599.328080630269, 5644.717764111778, 5654.717264136777, 5657.0, 5664.915026274609, 5493.560515158778, 5569.777208911598, 5624.437556244425, 5625.493705566437, 5711.514521265656, 5639.2668953035845, 5646.6894320811925, 5648.5763567731765, 5655.095184770417, 5693.0, 5614.63504872182, 5658.971705141448, 5663.122216056518, 5665.235193248941, 5672.319321681342, 4225.72532785368, 4310.051788606502, 4310.374995625617, 4359.324304732771, 4361.760103194355, 3876.496055512822, 3925.0187453136714, 3926.0381206604566, 3927.7643341399607, 3999.7000224983244, 5428.185772134211, 5434.021876062267, 5435.619506634498, 5483.150111732608, 5485.0, 5579.2746942897975, 5801.593888427769, 5802.79690210849, 5811.912821307684, 5814.476697097281, 5292.179712144623, 5315.176147697113, 5329.600279978939, 5344.786208551614, 5408.567314614821, 4905.435874874435, 4914.311996320518, 4914.606831453475, 4917.262410638433, 4920.950790492049, 5776.653400795965, 5895.64626122434, 5954.315253745788, 5958.225430693982, 5958.344582095966, 5699.971500142473, 5746.741396637245, 5756.683382414008, 5791.420857914175, 5843.766249350148, 5971.790987315423, 5996.310424301261, 5997.790077347272, 6000.249968753906, 6001.609895356788, 5432.619716619799, 5672.829815105389, 5679.6876171810945, 5681.034224181982, 5682.744276507649, 5649.350324712546, 5674.0, 5705.0, 5724.055530837365, 5779.8555036124435, 5513.696746678971, 5581.079121944834, 5587.469190426903, 5589.077802162597, 5592.105263157875, 5370.62405631602, 5574.108142697149, 5576.721163941867, 5587.161925711176, 5591.440855914376, 5416.404195538409, 5472.835814925558, 5519.2824932758485, 5558.305211848519, 5614.550835933197, 5575.414581468887, 5583.330000399978, 5613.550915926634, 5637.069883469182, 5640.520555752807, 5371.892562148657, 5397.622166448311, 5447.564194864481, 5455.345358556999, 5456.263404440349], "value": 5256.380547796167, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.8420926349886, 613.1171113596423, 614.5390956782413, 630.124127462827, 644.4264604501991, 32556.1860953476, 33248.66751332486, 35897.28205435896, 35911.0, 35980.82009589955, 45542.0, 46600.76699616505, 46703.53296467035, 51346.37882590566, 51361.743191284084, 9010.81978360434, 9175.082491750838, 9180.081991800833, 9187.908120918772, 9188.724338269829, 9095.681651142211, 9182.494962777044, 9186.26509879208, 9186.58660360282, 9186.954065229664, 9182.265418766483, 9209.539523023856, 9227.769305767342, 9233.769155771091, 9234.538273086353, 9152.267818574532, 9216.861747073799, 9222.262219022463, 9230.861537076915, 9231.307651926132, 9026.142516460992, 9080.727578172666, 9081.636734530612, 9084.227840633554, 9087.409318394282, 44545.55454445446, 44817.77591112056, 44846.327305090446, 44902.85680002401, 44935.325970110476, 3400.60892997306, 3499.1077275294892, 3564.590072141711, 3590.910227244314, 3693.538307711536, 34421.655783442344, 34748.65251347505, 35067.649323506696, 35487.82256088729, 36075.0, 3839.6733205145906, 3840.865569705075, 3898.142408670088, 4020.517537895442, 4023.3562629979065, 345627.0, 346960.0, 348356.0, 349939.0, 350076.0, 36036.0, 61004.694976524836, 61165.38834611686, 61435.69282153561, 61458.0, 36757.26485470276, 39004.80497597494, 39200.41199382012, 39354.0, 39565.604343956766, 15558.766618500731, 15698.0, 15708.842911570966, 15721.449749258722, 15724.371025159095, 13106.934465327613, 13247.403866826016, 13344.266065366499, 13362.599122026355, 13364.0, 8762.912370876336, 8817.867731984026, 8826.602802873886, 8925.107489251022, 8932.508712020901, 3339.966600334014, 3372.207531230159, 3394.2362968331927, 3459.498372735939, 3460.913477163091, 1049.186880167876, 1052.02335173046, 1060.2260349944584, 1104.3925840787535, 1126.4086354663702, 34090.318193636485, 34161.14597135092, 34231.828840856135, 34381.65618343835, 35130.0, 910.8269428808505, 1096.9780604387868, 1104.276698762312, 1196.3778835005749, 1209.1173443386376, 16315.755263671055, 17415.91292043557, 17485.125743712764, 17505.0, 17553.98260021791, 567233.0, 568846.0, 571005.0, 571799.0, 571838.0, 60516.69741651264, 61114.38885611087, 61155.6942215295, 61262.38737612656, 61279.0, 1274.095392271479, 1286.292539103508, 1323.6161513161076, 1325.3770727757937, 1352.8241328627216, 30200.24499387533, 34590.0, 35205.0, 35208.295834083685, 35384.0, 53627.73186134044, 54000.729996349764, 54209.457905422016, 54221.45778542164, 54317.72841135927, 418001.0, 420753.0, 421072.0, 421165.0, 422435.0, 29571.556426654046, 30021.0, 30156.0, 30802.38395232038, 32187.356252874342, 50775.49224507855, 51822.74088629533, 51891.0, 51936.740316299685, 51976.0, 42316.78841605772, 42844.0, 43110.78444607757, 43664.0, 45145.0, 43149.78425107854, 43807.780961096265, 44564.0, 44639.55360446354, 44999.550004500845, 38763.0, 39892.0, 39948.0, 40141.0, 40522.0, 35272.82363588166, 38036.0, 38132.809335954254, 38377.80811095927, 39268.2146357077, 29050.27374315659, 29057.12828615145, 29068.854655726587, 29130.56304155397, 29629.5555566671], "value": 19412.501369611018, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.2812655953686, 392.85268024490796, 401.12754758400473, 405.2947870704973, 414.5490782262083, 13756.44974201032, 17369.565760855985, 19153.712694309597, 19174.712379314322, 19603.803961960377, 18868.43394698158, 19427.32004379847, 19432.90283548584, 19676.70484942727, 19711.211551537923, 5673.290838645169, 5752.453516915886, 5794.6523208607405, 5887.558433117512, 5888.352281249059, 5614.101743720985, 5685.829425117253, 5736.512396446307, 5738.31140263169, 5763.452472015173, 5554.638948468357, 5762.3373312069225, 5770.249867517216, 5770.826875193751, 5797.420257974211, 5839.8540036499, 5871.8532036699, 5877.794277200299, 5880.4119588041285, 6214.533909956726, 5691.459311365414, 5844.444777746107, 5853.151293062525, 5857.47282744555, 5862.472377486047, 14162.36269367881, 17252.48242552713, 20156.395308140778, 23005.654915176285, 23130.7686923132, 2246.8988895499742, 2411.180198732422, 2514.798816094708, 2746.7115952824865, 2797.9020734274404, 9933.304668673196, 10595.364278143259, 10617.73455663607, 11125.27685700435, 14328.28358582077, 1872.896990665513, 1891.9716204256947, 1902.7526421565246, 1905.7046157845557, 1973.4671638657626, 81722.59138704329, 85690.14309856883, 86435.0, 88724.0, 88753.0, 10795.29830561011, 10974.0, 10974.451277436096, 11135.109191264679, 11142.331460112257, 15795.763063554055, 15842.12868292255, 15842.28709708066, 15856.920715396349, 15876.126813025163, 8042.477238979448, 8281.17188281167, 8326.625301861432, 8366.0, 8516.190961858614, 7723.768286951288, 7836.921630783733, 8015.438919275594, 8109.270165685117, 8126.634301456449, 4746.691465054761, 4843.2250839865455, 4873.926891096637, 4877.414710234794, 4958.752062396938, 1885.4720678210124, 1987.6322880267196, 2004.0, 2012.5169959209977, 2013.2550956146026, 966.7631430299622, 970.1753509516855, 977.3354119199013, 1038.963636272742, 1073.1093192650083, 18094.64290178242, 18594.0, 19582.31461898827, 19614.0, 19978.400647980583, 914.7164379042518, 947.924166066713, 970.9223262139012, 971.844504879216, 978.6917121106828, 10539.156867450585, 10854.34873907568, 10984.560617575367, 11007.944960275308, 11012.889871101186, 550880.4207621333, 554133.0, 556887.0, 574001.0, 577716.0, 85065.57467212624, 95159.0, 96062.0, 100656.49671751594, 100792.0, 957.2533423929347, 990.0990099009866, 999.480270259461, 1005.8038682456851, 1009.6769033909079, 16030.599235019217, 16797.66404671924, 16973.575660608585, 17112.401065962633, 18014.819851801316, 43854.56145438633, 43893.78053109714, 44137.0, 45002.77498612617, 45296.320555191036, 57560.0, 61140.38859611525, 62097.0, 62511.6874415625, 64322.35677643351, 8581.669841174627, 8759.562021898751, 8845.69040083594, 8869.955650221707, 8897.0, 10059.346142500714, 13071.934640327117, 13166.012549058667, 13311.400986955416, 13694.93152534231, 11298.209125361145, 11551.422428878355, 11660.766784664089, 11681.182317237712, 11956.222845515014, 11488.425578720864, 11538.307701537935, 11565.653030409101, 11663.066954643438, 12002.699932501408, 11718.414079295831, 11735.47190376418, 11925.0, 12023.27860328383, 12029.037676985645, 8618.956905215433, 8652.134786521297, 8677.349198809989, 8732.56337183151, 9005.684801031932, 9603.759906002406, 11317.320960742381, 11340.432978351215, 11395.601153959904, 11731.7516883895], "value": 9324.5650781516, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.4353371583934, 1457.6938842843003, 1530.3343045775089, 1637.3450619752098, 1757.8857374270663, 8459.746207613774, 8768.605412756426, 8910.198082172603, 9130.178283954443, 9266.07339266073, 9011.864822027675, 9140.131687489678, 9149.0, 9152.130547597968, 9152.588133533991, 2338.7076615423116, 2341.3678306857137, 2363.3737059679197, 2364.858108513486, 2365.5860224460653, 2335.8481698689616, 2397.820163487737, 2431.8540887546715, 2436.049940523197, 2436.8537887726793, 2298.678185054094, 2308.4575124845646, 2351.5061837014164, 2428.9757102428925, 2433.6957880264968, 2350.847194932324, 2370.2652177824843, 2377.6552399901916, 2379.3456799380137, 2380.5000949800565, 2254.3124347074136, 2278.703768510083, 2279.282026161754, 2280.1791355112146, 2285.074544809355, 8372.204640559137, 9058.592363343665, 9158.49628270445, 9169.0, 9183.49490778007, 5306.0, 5495.725213739337, 5501.9174712379345, 5502.697351645658, 5506.531944784658, 3617.6924961378313, 3664.633536646341, 3683.631636836322, 3729.757565758217, 3736.7384283100196, 1192.8807119288, 1200.789861774186, 1215.6535387414544, 1231.839860818097, 1236.369451579692, 12846.0, 12851.678708032374, 12863.935680321538, 12876.0, 12939.935300323532, 4474.4048451897825, 4652.55800698933, 4838.371011768518, 4838.975805120952, 4850.466448690641, 9953.651622193189, 9996.050375214343, 9996.50017499122, 9997.55011024491, 10000.24998125129, 5405.351357837006, 5417.6478528895495, 5423.783048678088, 5426.972865135649, 5430.67415955044, 3950.58518855516, 4265.424167737316, 4409.11817636474, 4847.491013443609, 5051.747412629354, 3866.903327416837, 3905.4727611772046, 4004.5394779600138, 4012.578679238696, 4015.0765323975647, 1133.6202372205403, 1172.3903570143477, 1174.2719513901266, 1184.4492311075392, 1184.7452797648548, 872.289084396215, 963.1620490173594, 989.2827699917646, 996.0487734213808, 1025.29254814178, 5898.705064746746, 6036.275646922398, 6090.908636370458, 6099.420555047263, 6150.108234306001, 455.8769132334251, 466.6360239013575, 490.32527562148397, 490.3894651159329, 491.0326656486715, 4164.979175104105, 4206.158768246363, 4251.489821221411, 4287.442632457761, 4304.332828411601, 11164.218504704593, 11373.886261137448, 11518.827217591743, 11521.193516453935, 11541.942290288494, 10650.520726567323, 11132.833007504894, 11144.721381965353, 11443.313401195956, 11460.54157833694, 8386.161383861687, 8576.0, 8612.224899758927, 8614.39699221061, 8621.69824056155, 6124.755009799558, 6179.351168127282, 6276.811695649138, 6330.303666596578, 6500.349965003651, 10459.215558832966, 10459.843102353623, 10478.528466218886, 10531.526081326205, 10583.62957296491, 10056.34633748804, 10174.694759157237, 10587.047165755119, 10714.73213169677, 10715.892841071802, 7940.205979402013, 8167.14245004266, 8188.5905704715715, 8189.918100818915, 8194.180581941759, 8664.436811607226, 8735.301175905784, 8878.556072196236, 8942.955285223792, 8954.776130596527, 7941.8411631768195, 7998.5600791957, 8014.919850801417, 8092.6762929482165, 8279.130691277329, 7846.058472983279, 7915.762527124196, 7919.722809701633, 7961.960190199012, 8025.879611805711, 7070.222275549582, 7104.325089116525, 7181.605011724405, 7201.603911784902, 7204.24355442671, 5028.515788009499, 5238.030964271622, 5240.633155679218, 5271.367435907716, 5289.069355822314, 5408.648437851527, 5461.890762184814, 5514.228008078952, 5587.7485513152815, 5722.0], "value": 4662.779453045931, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.24112215731947, 324.0909249554999, 329.5106766451819, 345.319720151302, 349.56479183416616, 5006.649534532584, 5160.0, 5197.402298735647, 5220.399654039787, 5226.346706661668, 5181.922271165936, 5197.8440646780655, 5198.844034678957, 5199.558037566811, 5205.687658740479, 4151.46031015969, 4156.251874662559, 4158.230727315448, 4161.4382058422025, 4163.084980908786, 4017.718759686823, 4029.597040295976, 4104.610062044101, 4118.876433706993, 4170.332746760519, 4039.293123703355, 4044.1488750430876, 4049.4533238012787, 4062.2890994076065, 4064.97967510162, 4067.2068946555432, 4070.124923141524, 4071.165411090749, 4077.3476243800997, 4080.2451546463703, 3663.0, 3686.7972261525606, 3688.723345749053, 3696.722745794076, 3696.9260614787822, 4917.827876024322, 5077.619178561586, 5099.668521546125, 5100.566451851597, 5108.770105345231, 4702.717836929795, 4720.858374248778, 4728.881777955544, 4729.196036673774, 4729.55069268419, 5262.342207224097, 5430.891382172374, 5435.804123092913, 5450.945490545084, 5452.473307473913, 4005.3190957537, 4016.9598304016877, 4024.7383920045104, 4037.9097643636055, 4039.232545816315, 5360.463953604647, 5366.141417373202, 5641.943580564182, 5643.7460314285545, 5649.389923871677, 4044.3933409988736, 4051.913264668698, 4052.392141178788, 4053.169100334483, 4060.553339132693, 4084.345839934831, 4087.3460246361033, 4097.774622395737, 4104.610062044101, 4105.2405305018665, 4453.0, 4613.677042606985, 4631.564215093332, 4632.698874573142, 4633.166030114612, 5385.6230063895155, 5398.24424580559, 5413.188021796684, 5413.621046526784, 5415.891682166334, 1396.7010680067635, 1409.3516982188103, 1409.7391982483273, 1417.4046900301898, 1418.0569921002418, 869.2481003931554, 918.7703074231442, 935.5930170375908, 938.8779458670466, 943.4339396362128, 4563.931541026887, 4581.885452863705, 4588.541145885385, 4592.448906131285, 4599.2871104978785, 4805.27920811881, 4839.2983017462275, 4894.458245652608, 4928.0, 4934.55588996992, 4412.779361031936, 4508.864734057984, 4538.841140560065, 4622.2835460503675, 4638.744869032168, 2569.7044839843284, 2586.689597248342, 2587.469568738404, 2589.6503971963543, 2601.648777415063, 5002.399712034579, 5009.774560144802, 5010.574101201366, 5018.824341148043, 5028.466317773041, 4753.0, 4939.653664509329, 4946.629002824802, 4966.304717339575, 4972.975135124301, 4970.254461830755, 4979.228219625964, 4987.177115775857, 5009.624278179078, 5010.624203184776, 4765.666403351732, 4815.242436510718, 4827.42070951488, 4830.613550915848, 4834.782434790513, 4527.750973696347, 4773.689710168828, 4778.856634300976, 4805.414213309529, 4825.6139508839915, 4990.600751939909, 5014.0, 5493.0, 5615.410381910004, 5738.626989245686, 4090.284200264882, 4106.0, 4107.527634322091, 4112.91774164509, 4116.876493705194, 5568.916466252928, 5571.857769157232, 5578.63738856973, 5585.441455854382, 5589.888202236014, 5222.206119725928, 5468.2344471773185, 5472.042392581203, 5474.671519708831, 5489.780408783604, 5416.697903391122, 5446.645968012067, 5451.936872309861, 5465.890682186414, 5476.424975377528, 5212.921806172986, 5402.378726446509, 5415.673160075807, 5416.783328666967, 5427.077396842467, 5433.157860531624, 5481.862953426196, 5496.780128794963, 5509.724513774215, 5522.779088836563, 5370.758315875873, 5376.198973343973, 5377.112776392008, 5388.164834450667, 5413.941123265343], "value": 4028.8930858989756, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.9892901606477, 744.2445917393843, 755.9130699969505, 794.9602519874006, 854.0562678240548, 16077.51767446977, 16731.414400495985, 16760.916195419035, 16766.413175538873, 16777.32890684371, 15397.0, 15520.456784012562, 15590.766138507932, 15602.297896594651, 15603.765943510827, 669.2972379002052, 807.2008711375754, 818.3698552114882, 829.0258945738763, 832.950022998622, 816.2082779703708, 820.5938060659981, 822.1613953767154, 822.8189798244376, 823.8928939237891, 871.4640496094888, 871.9433236839585, 872.8297981893534, 872.9956350218272, 873.0701802580263, 707.6178863413802, 847.6355167278068, 870.4951128345544, 870.6865528409768, 871.1549796697194, 631.0880777276836, 631.5421319543341, 632.0645444741808, 632.4782054804758, 634.552640388525, 14016.85983140176, 14054.086484378482, 14070.22613756243, 14077.577672669837, 14095.859041409558, 13781.724365512633, 14015.956261421179, 14344.64138396538, 14913.92543037278, 15115.848841511553, 13279.867201328056, 13390.196588204739, 13531.32343382827, 13559.661008474768, 13689.247091409969, 4343.478782546114, 4388.890277743082, 4399.780010999437, 4445.0, 4477.1493416250805, 63766.0, 65074.0, 66033.0, 80354.99999999942, 81587.59206203932, 11677.649670509898, 11726.589569365031, 11818.940905295418, 11972.940135299268, 12206.206596571194, 19729.210831566576, 19744.40766776999, 19792.109355079057, 19829.206831726857, 19852.503687407643, 9043.095690430904, 9083.318751093562, 9100.499472528942, 9112.362134650644, 9437.197838183694, 4946.431160416526, 4960.751962401938, 4988.55103040728, 5015.197568389113, 5145.974270128625, 3553.680168784822, 3666.4866918631415, 3696.8890933272046, 3696.9815150924073, 3698.815059247027, 600.4115966352998, 601.3685630088389, 603.4491357212011, 608.5131894484394, 620.8137558732362, 670.5373292428209, 699.349604867468, 730.4047201530735, 766.3218052023999, 788.1094363369356, 9906.900930990741, 10247.077763001365, 10513.52689128991, 10546.209034322457, 10667.359958402521, 747.4905319524779, 752.762879692895, 756.1644382956863, 771.1709911844789, 774.5120574038432, 4634.582887540138, 5006.599472042228, 5035.697858128524, 5058.822941197114, 5061.974690126526, 75217.0, 97002.0, 127043.0, 132832.3358383202, 133601.0, 63164.105076847765, 96505.0, 104412.47793761134, 104937.47531262295, 106236.0, 82417.58791206125, 84133.57933210417, 84614.57692711498, 86929.13070869337, 88766.55616721875, 9913.256505761952, 10204.0, 10353.0, 10420.47897605132, 10470.267081304235, 48070.27894581654, 49675.25487117768, 50198.74900625474, 51290.48709513006, 52166.47833521616, 71867.64066179635, 73420.29086945794, 77678.0, 78218.6089069551, 79123.0, 13350.0, 13424.39590218423, 13599.59201223965, 13716.245606491739, 14388.928055359656, 15283.769009044738, 15748.370065197263, 15936.442224522087, 16116.355345786038, 16412.507624771275, 14267.49688667497, 15020.849791501945, 15140.091594503925, 15369.231538422811, 15507.844921551092, 13561.932190338985, 13887.861121388656, 14244.857551424353, 14411.92794036023, 14892.473653308458, 13725.794113088112, 13896.58310250694, 14105.576832695035, 14216.573502794932, 14541.27293635335, 11679.766404671689, 11885.34630595291, 12108.394580270775, 12145.939270303592, 12254.0, 10918.727031824268, 11024.516643412142, 11369.772604548029, 12205.267683938991, 12639.620811375673], "value": 7777.9926970564775, "unit": "score"}], "name": "dromaeo_css", "value": 7197.641665708334, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 112.0, 112.0, 112.0, 111.0, 111.0, 110.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 122.0, 172.0, 122.0, 117.0, 142.0, 120.0, 165.0, 117.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 159.0, 158.0, 159.0, 159.0, 160.0, 161.0, 161.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 108.0, 75.0, 76.0, 75.0, 75.0, 98.0, 74.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 131.0, 84.0, 84.0, 84.0, 118.0, 85.0, 84.0, 123.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 51.0, 49.0, 50.0, 51.0, 50.0, 53.0, 50.0, 51.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 76.0, 76.0, 76.0, 76.0, 77.0, 76.0, 77.0, 75.0, 81.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 120.0, 121.0, 122.0, 119.0, 121.0, 118.0, 145.0, 123.0], "value": 123.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 161.0, 160.0, 161.0, 162.0, 160.0, 160.0, 161.0, 163.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 64.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1476.8, "alertThreshold": 2.0}]} 20:17:17 INFO - Return code: 0 20:17:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:17:18 INFO - # TBPL SUCCESS # 20:17:18 INFO - Running post-action listener: _resource_record_post_action 20:17:18 INFO - [mozharness: 2016-08-10 03:17:18.036662Z] Finished run-tests step (success) 20:17:18 INFO - Running post-run listener: _resource_record_post_run 20:17:18 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 233472; Write bytes: 550891520; Read time: 440; Write time: 505752 20:17:18 INFO - TinderboxPrint: CPU usage
13.1% 20:17:18 INFO - TinderboxPrint: I/O read bytes / time
233,472 / 440 20:17:18 INFO - TinderboxPrint: I/O write bytes / time
550,891,520 / 505,752 20:17:18 INFO - TinderboxPrint: CPU idle
8,276.1 (86.9%) 20:17:18 INFO - TinderboxPrint: CPU user
1,199.6 (12.6%) 20:17:18 INFO - TinderboxPrint: Swap in / out
0 / 0 20:17:18 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 8192; Write bytes: 258756608; Read time: 220; Write time: 250384 20:17:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 221184; Write bytes: 291954688; Read time: 208; Write time: 255344 20:17:18 INFO - Running post-run listener: _upload_blobber_files 20:17:18 INFO - Blob upload gear active. 20:17:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:17:18 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 20:17:18 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:17:18 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:17:19 INFO - (blobuploader) - INFO - Open directory for files ... 20:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:19 INFO - (blobuploader) - INFO - Done attempting. 20:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:17:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:20 INFO - (blobuploader) - INFO - Done attempting. 20:17:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:17:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:24 INFO - (blobuploader) - INFO - Done attempting. 20:17:24 INFO - (blobuploader) - INFO - Iteration through files over. 20:17:24 INFO - Return code: 0 20:17:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:17:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:17:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54f8dcf22ef763d8e8416bc17ce3bbf27fa3946173dbf9ca5462432f4b69301083c1ad053c1029f3ca335872c75d7ccc45460997501b3dec69dd32225e7c4ccd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34fbd436447e42c99a1a90b6a7e092fd720b5b3245e0235a9cd53a6485d5706ad355f8504931489aa2d43842356e805eaf3454e4135ec528e76c2dff02e96308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2de65c89e282c32211e49fa60e2e0bc43cd3581e4110572ee09cefe1e3cc006b36c8d52f12376f32acad9ef6ef65cf6290f63564f12e119e4e0d2825e39fc47"} 20:17:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:17:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:17:24 INFO - Contents: 20:17:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54f8dcf22ef763d8e8416bc17ce3bbf27fa3946173dbf9ca5462432f4b69301083c1ad053c1029f3ca335872c75d7ccc45460997501b3dec69dd32225e7c4ccd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34fbd436447e42c99a1a90b6a7e092fd720b5b3245e0235a9cd53a6485d5706ad355f8504931489aa2d43842356e805eaf3454e4135ec528e76c2dff02e96308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2de65c89e282c32211e49fa60e2e0bc43cd3581e4110572ee09cefe1e3cc006b36c8d52f12376f32acad9ef6ef65cf6290f63564f12e119e4e0d2825e39fc47"} 20:17:24 INFO - Running post-run listener: copy_logs_to_upload_dir 20:17:24 INFO - Copying logs to upload dir... 20:17:24 INFO - mkdir: /builds/slave/test/build/upload/logs 20:17:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.058706 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-09 20:17:24.149907) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 20:17:24.153574) ========= 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=41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831 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/sha512/54f8dcf22ef763d8e8416bc17ce3bbf27fa3946173dbf9ca5462432f4b69301083c1ad053c1029f3ca335872c75d7ccc45460997501b3dec69dd32225e7c4ccd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34fbd436447e42c99a1a90b6a7e092fd720b5b3245e0235a9cd53a6485d5706ad355f8504931489aa2d43842356e805eaf3454e4135ec528e76c2dff02e96308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2de65c89e282c32211e49fa60e2e0bc43cd3581e4110572ee09cefe1e3cc006b36c8d52f12376f32acad9ef6ef65cf6290f63564f12e119e4e0d2825e39fc47"} build_url:https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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/sha512/54f8dcf22ef763d8e8416bc17ce3bbf27fa3946173dbf9ca5462432f4b69301083c1ad053c1029f3ca335872c75d7ccc45460997501b3dec69dd32225e7c4ccd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34fbd436447e42c99a1a90b6a7e092fd720b5b3245e0235a9cd53a6485d5706ad355f8504931489aa2d43842356e805eaf3454e4135ec528e76c2dff02e96308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2de65c89e282c32211e49fa60e2e0bc43cd3581e4110572ee09cefe1e3cc006b36c8d52f12376f32acad9ef6ef65cf6290f63564f12e119e4e0d2825e39fc47"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 20:17:24.178604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 20:17:24.178924) ========= 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=41bf3e9aed84707956354da8000001c5-1470796247.516409-1970486831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 20:17:24.260982) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 20:17:24.261322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 20:17:24.261622) ========= ========= Total master_lag: 0.18 =========