builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1467290114.76 results: success (0) buildid: 20160630050225 builduid: f5fea4a189894aa5826a637a6515efe1 revision: 4e695d4a3a8426bb41bebf29033ab826a572c8bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:14.756668) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:14.757128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:14.757420) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:14.780112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:14.780461) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 05:35:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-06-30 05:35:14 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173416 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:14.986459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:14.986860) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.054406 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:15.051474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:15.051871) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4e695d4a3a8426bb41bebf29033ab826a572c8bd --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 4e695d4a3a8426bb41bebf29033ab826a572c8bd --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=17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 05:35:15,115 truncating revision to first 12 chars 2016-06-30 05:35:15,115 Setting DEBUG logging. 2016-06-30 05:35:15,115 attempt 1/10 2016-06-30 05:35:15,115 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4e695d4a3a84?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 05:35:15,428 unpacking tar archive at: fx-team-4e695d4a3a84/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669049 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:15.734832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:15.735163) ========= script_repo_revision: 4e695d4a3a8426bb41bebf29033ab826a572c8bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:15.735574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:15.735848) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:35:15.745289) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-30 05:35:15.745743) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:35:15 INFO - MultiFileLogger online at 20160630 05:35:15 in /builds/slave/test 05:35:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:35:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:35:15 INFO - {'append_to_log': False, 05:35:15 INFO - 'base_work_dir': '/builds/slave/test', 05:35:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:35:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:35:15 INFO - 'branch': 'Fx-Team-Non-PGO', 05:35:15 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:15 INFO - 'config_files': ('talos/linux_config.py',), 05:35:15 INFO - 'default_actions': ('clobber', 05:35:15 INFO - 'read-buildbot-config', 05:35:15 INFO - 'download-and-extract', 05:35:15 INFO - 'populate-webroot', 05:35:15 INFO - 'create-virtualenv', 05:35:15 INFO - 'install', 05:35:15 INFO - 'run-tests'), 05:35:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:15 INFO - 'download_minidump_stackwalk': True, 05:35:15 INFO - 'download_symbols': 'ondemand', 05:35:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:15 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:15 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:15 INFO - 'installer_path': 'installer.exe', 05:35:15 INFO - 'log_level': 'info', 05:35:15 INFO - 'log_name': 'talos', 05:35:15 INFO - 'log_to_console': True, 05:35:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:35:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:35:15 INFO - 'opt_config_files': (), 05:35:15 INFO - 'pip_index': False, 05:35:15 INFO - 'sps_profile': False, 05:35:15 INFO - 'sps_profile_interval': 0, 05:35:15 INFO - 'suite': 'dromaeojs', 05:35:15 INFO - 'system_bits': '32', 05:35:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:15 INFO - 'title': 'talos-linux64-ix-009', 05:35:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:15 INFO - 'use_talos_json': True, 05:35:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:35:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:15 INFO - 'work_dir': 'build'} 05:35:15 INFO - ##### 05:35:15 INFO - ##### Running clobber step. 05:35:15 INFO - ##### 05:35:15 INFO - Running pre-action listener: _resource_record_pre_action 05:35:15 INFO - Running main action method: clobber 05:35:15 INFO - rmtree: /builds/slave/test/build 05:35:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:35:18 INFO - Running post-action listener: _resource_record_post_action 05:35:18 INFO - ##### 05:35:18 INFO - ##### Finished clobber step (success) 05:35:18 INFO - ##### 05:35:18 INFO - ##### 05:35:18 INFO - ##### Running read-buildbot-config step. 05:35:18 INFO - ##### 05:35:18 INFO - Running pre-action listener: _resource_record_pre_action 05:35:18 INFO - Running main action method: read_buildbot_config 05:35:18 INFO - Using buildbot properties: 05:35:18 INFO - { 05:35:18 INFO - "project": "", 05:35:18 INFO - "product": "firefox", 05:35:18 INFO - "script_repo_revision": "production", 05:35:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:35:18 INFO - "repository": "", 05:35:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:35:18 INFO - "buildid": "20160630050225", 05:35:18 INFO - "pgo_build": "False", 05:35:18 INFO - "basedir": "/builds/slave/test", 05:35:18 INFO - "buildnumber": 3125, 05:35:18 INFO - "slavename": "talos-linux64-ix-009", 05:35:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:35:18 INFO - "platform": "ubuntu64_hw", 05:35:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:35:18 INFO - "branch": "fx-team", 05:35:18 INFO - "repo_path": "integration/fx-team", 05:35:18 INFO - "revision": "4e695d4a3a8426bb41bebf29033ab826a572c8bd", 05:35:18 INFO - "stage_platform": "linux64", 05:35:18 INFO - "builduid": "f5fea4a189894aa5826a637a6515efe1", 05:35:18 INFO - "slavebuilddir": "test" 05:35:18 INFO - } 05:35:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:35:18 INFO - Running post-action listener: _resource_record_post_action 05:35:18 INFO - ##### 05:35:18 INFO - ##### Finished read-buildbot-config step (success) 05:35:18 INFO - ##### 05:35:18 INFO - ##### 05:35:18 INFO - ##### Running download-and-extract step. 05:35:18 INFO - ##### 05:35:18 INFO - Running pre-action listener: _resource_record_pre_action 05:35:18 INFO - Running main action method: download_and_extract 05:35:18 INFO - mkdir: /builds/slave/test/build/tests 05:35:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:18 INFO - https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:35:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:35:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:35:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:35:19 INFO - Downloaded 1361 bytes. 05:35:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:35:19 INFO - Using the following test package requirements: 05:35:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:35:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:35:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:19 INFO - u'jsshell-linux-x86_64.zip'], 05:35:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:35:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:35:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:35:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:35:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:35:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:19 INFO - https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:35:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:35:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:35:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:35:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:35:20 INFO - Downloaded 22701925 bytes. 05:35:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:35:21 INFO - Return code: 0 05:35:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:21 INFO - https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:35:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:35:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:35:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:35:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:35:23 INFO - Downloaded 22701925 bytes. 05:35:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:35:24 INFO - Return code: 0 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:24 INFO - https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:35:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:35:25 INFO - Downloaded 14405242 bytes. 05:35:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:35:25 INFO - Return code: 0 05:35:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:25 INFO - https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:35:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:35:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:35:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:35:29 INFO - Downloaded 56450995 bytes. 05:35:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:35:29 INFO - mkdir: /builds/slave/test/properties 05:35:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:29 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:29 INFO - Contents: 05:35:29 INFO - build_url:https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:35:29 INFO - Running post-action listener: _resource_record_post_action 05:35:29 INFO - Running post-action listener: set_extra_try_arguments 05:35:29 INFO - ##### 05:35:29 INFO - ##### Finished download-and-extract step (success) 05:35:29 INFO - ##### 05:35:29 INFO - ##### 05:35:29 INFO - ##### Running populate-webroot step. 05:35:29 INFO - ##### 05:35:29 INFO - Running pre-action listener: _resource_record_pre_action 05:35:29 INFO - Running main action method: populate_webroot 05:35:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:29 INFO - '--tppagecycles', 05:35:29 INFO - '7'], 05:35:29 INFO - 'tests': ['tsvgm']}}, 05:35:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:35:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:35:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:35:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:29 INFO - 'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:29 INFO - 'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['damp', 'tps']}, 05:35:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:29 INFO - 'tests': ['damp', 'tps']}, 05:35:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['dromaeo_dom']}, 05:35:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['basic_compositor_video']}, 05:35:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:35:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['a11yr', 05:35:29 INFO - 'ts_paint', 05:35:29 INFO - 'tpaint', 05:35:29 INFO - 'sessionrestore', 05:35:29 INFO - 'sessionrestore_no_auto_restore', 05:35:29 INFO - 'tabpaint']}, 05:35:29 INFO - 'other-e10s': {'tests': ['a11yr', 05:35:29 INFO - 'ts_paint', 05:35:29 INFO - 'tpaint', 05:35:29 INFO - 'sessionrestore', 05:35:29 INFO - 'sessionrestore_no_auto_restore', 05:35:29 INFO - 'tabpaint']}, 05:35:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:35:29 INFO - 'ts_paint', 05:35:29 INFO - 'tpaint', 05:35:29 INFO - 'sessionrestore', 05:35:29 INFO - 'sessionrestore_no_auto_restore', 05:35:29 INFO - 'tabpaint']}, 05:35:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:35:29 INFO - 'ts_paint', 05:35:29 INFO - 'tpaint', 05:35:29 INFO - 'sessionrestore', 05:35:29 INFO - 'sessionrestore_no_auto_restore', 05:35:29 INFO - 'tabpaint']}, 05:35:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['a11yr', 05:35:29 INFO - 'ts_paint', 05:35:29 INFO - 'tpaint', 05:35:29 INFO - 'sessionrestore', 05:35:29 INFO - 'sessionrestore_no_auto_restore', 05:35:29 INFO - 'tabpaint']}, 05:35:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['a11yr', 05:35:29 INFO - 'ts_paint', 05:35:29 INFO - 'tpaint', 05:35:29 INFO - 'sessionrestore', 05:35:29 INFO - 'sessionrestore_no_auto_restore', 05:35:29 INFO - 'tabpaint']}, 05:35:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['tsvgx', 05:35:29 INFO - 'tsvgr_opacity', 05:35:29 INFO - 'tart', 05:35:29 INFO - 'tscrollx', 05:35:29 INFO - 'cart']}, 05:35:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:35:29 INFO - 'tsvgr_opacity', 05:35:29 INFO - 'tart', 05:35:29 INFO - 'tscrollx', 05:35:29 INFO - 'cart']}, 05:35:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:29 INFO - 'talos_options': ['--disable-e10s'], 05:35:29 INFO - 'tests': ['tp5o']}, 05:35:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:29 INFO - 'tests': ['tp5o']}, 05:35:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:29 INFO - 'talos_options': ['--disable-e10s', 05:35:29 INFO - '--xperf_path', 05:35:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:29 INFO - 'tests': ['tp5n']}, 05:35:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:29 INFO - 'talos_options': ['--xperf_path', 05:35:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:29 INFO - 'tests': ['tp5n']}}, 05:35:29 INFO - 'talos.zip': {'path': '', 05:35:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:29 INFO - Running post-action listener: _resource_record_post_action 05:35:29 INFO - ##### 05:35:29 INFO - ##### Finished populate-webroot step (success) 05:35:29 INFO - ##### 05:35:29 INFO - ##### 05:35:29 INFO - ##### Running create-virtualenv step. 05:35:29 INFO - ##### 05:35:29 INFO - Running pre-action listener: _resource_record_pre_action 05:35:29 INFO - Running main action method: create_virtualenv 05:35:29 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:29 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 05:35:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:30 INFO - Using real prefix '/usr' 05:35:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:35 INFO - Installing pip.................done. 05:35:35 INFO - Return code: 0 05:35:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13683b0>, '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 0x13692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1369740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', '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 05:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:35:35 INFO - Using env: {'DISPLAY': ':0', 05:35:35 INFO - 'HOME': '/home/cltbld', 05:35:35 INFO - 'LANG': 'en_US.UTF-8', 05:35:35 INFO - 'LANGUAGE': 'en_US:en', 05:35:35 INFO - 'LOGNAME': 'cltbld', 05:35:35 INFO - 'MAIL': '/var/mail/cltbld', 05:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:35 INFO - 'MOZ_NO_REMOTE': '1', 05:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:35 INFO - 'NO_EM_RESTART': '1', 05:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:35 INFO - 'PWD': '/builds/slave/test', 05:35:35 INFO - 'SHELL': '/bin/bash', 05:35:35 INFO - 'SHLVL': '1', 05:35:35 INFO - 'TERM': 'linux', 05:35:35 INFO - 'TMOUT': '86400', 05:35:35 INFO - 'USER': 'cltbld', 05:35:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', 05:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:35 INFO - '_': '/tools/buildbot/bin/python'} 05:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:35 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 05:35:35 INFO - Cleaning up... 05:35:35 INFO - Return code: 0 05:35:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13683b0>, '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 0x13692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1369740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', '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 05:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:35:35 INFO - Using env: {'DISPLAY': ':0', 05:35:35 INFO - 'HOME': '/home/cltbld', 05:35:35 INFO - 'LANG': 'en_US.UTF-8', 05:35:35 INFO - 'LANGUAGE': 'en_US:en', 05:35:35 INFO - 'LOGNAME': 'cltbld', 05:35:35 INFO - 'MAIL': '/var/mail/cltbld', 05:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:35 INFO - 'MOZ_NO_REMOTE': '1', 05:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:35 INFO - 'NO_EM_RESTART': '1', 05:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:35 INFO - 'PWD': '/builds/slave/test', 05:35:35 INFO - 'SHELL': '/bin/bash', 05:35:35 INFO - 'SHLVL': '1', 05:35:35 INFO - 'TERM': 'linux', 05:35:35 INFO - 'TMOUT': '86400', 05:35:35 INFO - 'USER': 'cltbld', 05:35:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', 05:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:35 INFO - '_': '/tools/buildbot/bin/python'} 05:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:35 INFO - Downloading/unpacking psutil>=3.1.1 05:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:37 INFO - Installing collected packages: psutil 05:35:37 INFO - Running setup.py install for psutil 05:35:37 INFO - building 'psutil._psutil_linux' extension 05:35:37 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 05:35:38 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 05:35:39 INFO - building 'psutil._psutil_posix' extension 05:35:39 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 05:35:39 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 05:35:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:39 INFO - Successfully installed psutil 05:35:39 INFO - Cleaning up... 05:35:39 INFO - Return code: 0 05:35:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:39 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 0x10a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13683b0>, '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 0x13692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1369740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', '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 05:35:39 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 05:35:39 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 05:35:39 INFO - Using env: {'DISPLAY': ':0', 05:35:39 INFO - 'HOME': '/home/cltbld', 05:35:39 INFO - 'LANG': 'en_US.UTF-8', 05:35:39 INFO - 'LANGUAGE': 'en_US:en', 05:35:39 INFO - 'LOGNAME': 'cltbld', 05:35:39 INFO - 'MAIL': '/var/mail/cltbld', 05:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:39 INFO - 'MOZ_NO_REMOTE': '1', 05:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:39 INFO - 'NO_EM_RESTART': '1', 05:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:39 INFO - 'PWD': '/builds/slave/test', 05:35:39 INFO - 'SHELL': '/bin/bash', 05:35:39 INFO - 'SHLVL': '1', 05:35:39 INFO - 'TERM': 'linux', 05:35:39 INFO - 'TMOUT': '86400', 05:35:39 INFO - 'USER': 'cltbld', 05:35:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', 05:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:39 INFO - '_': '/tools/buildbot/bin/python'} 05:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:35:39 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 05:35:39 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 05:35:39 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 05:35:39 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 05:35:39 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 05:35:39 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 05:35:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:35:41 INFO - Installing collected packages: mozsystemmonitor 05:35:41 INFO - Running setup.py install for mozsystemmonitor 05:35:41 INFO - Successfully installed mozsystemmonitor 05:35:41 INFO - Cleaning up... 05:35:41 INFO - Return code: 0 05:35:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:41 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 0x10a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13683b0>, '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 0x13692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1369740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', '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 05:35:41 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 05:35:41 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 05:35:41 INFO - Using env: {'DISPLAY': ':0', 05:35:41 INFO - 'HOME': '/home/cltbld', 05:35:41 INFO - 'LANG': 'en_US.UTF-8', 05:35:41 INFO - 'LANGUAGE': 'en_US:en', 05:35:41 INFO - 'LOGNAME': 'cltbld', 05:35:41 INFO - 'MAIL': '/var/mail/cltbld', 05:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:41 INFO - 'MOZ_NO_REMOTE': '1', 05:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:41 INFO - 'NO_EM_RESTART': '1', 05:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:41 INFO - 'PWD': '/builds/slave/test', 05:35:41 INFO - 'SHELL': '/bin/bash', 05:35:41 INFO - 'SHLVL': '1', 05:35:41 INFO - 'TERM': 'linux', 05:35:41 INFO - 'TMOUT': '86400', 05:35:41 INFO - 'USER': 'cltbld', 05:35:41 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', 05:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:41 INFO - '_': '/tools/buildbot/bin/python'} 05:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:41 INFO - Downloading/unpacking jsonschema==2.5.1 05:35:41 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 05:35:41 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 05:35:41 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 05:35:41 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 05:35:41 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 05:35:41 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 05:35:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:35:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:35:43 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 05:35:43 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 05:35:43 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 05:35:43 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 05:35:43 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 05:35:43 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 05:35:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:35:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:35:44 INFO - warning: no files found matching '*.txt' 05:35:44 INFO - no previously-included directories found matching 'build' 05:35:44 INFO - no previously-included directories found matching 'dist' 05:35:44 INFO - no previously-included directories found matching '.git*' 05:35:44 INFO - Installing collected packages: jsonschema, functools32 05:35:44 INFO - Running setup.py install for functools32 05:35:44 INFO - warning: no files found matching '*.txt' 05:35:44 INFO - no previously-included directories found matching 'build' 05:35:44 INFO - no previously-included directories found matching 'dist' 05:35:44 INFO - no previously-included directories found matching '.git*' 05:35:44 INFO - Successfully installed jsonschema functools32 05:35:44 INFO - Cleaning up... 05:35:44 INFO - Return code: 0 05:35:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:44 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 0x10a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13683b0>, '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 0x13692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1369740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', '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 05:35:44 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 05:35:44 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 05:35:44 INFO - Using env: {'DISPLAY': ':0', 05:35:44 INFO - 'HOME': '/home/cltbld', 05:35:44 INFO - 'LANG': 'en_US.UTF-8', 05:35:44 INFO - 'LANGUAGE': 'en_US:en', 05:35:44 INFO - 'LOGNAME': 'cltbld', 05:35:44 INFO - 'MAIL': '/var/mail/cltbld', 05:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:44 INFO - 'MOZ_NO_REMOTE': '1', 05:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:44 INFO - 'NO_EM_RESTART': '1', 05:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:44 INFO - 'PWD': '/builds/slave/test', 05:35:44 INFO - 'SHELL': '/bin/bash', 05:35:44 INFO - 'SHLVL': '1', 05:35:44 INFO - 'TERM': 'linux', 05:35:44 INFO - 'TMOUT': '86400', 05:35:44 INFO - 'USER': 'cltbld', 05:35:44 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', 05:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:44 INFO - '_': '/tools/buildbot/bin/python'} 05:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:35:44 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 05:35:44 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 05:35:44 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 05:35:44 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 05:35:44 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 05:35:44 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 05:35:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:35:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:35:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:47 INFO - Downloading docopt-0.6.1.tar.gz 05:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:35:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:35:47 INFO - Running setup.py install for blobuploader 05:35:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:35:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:35:47 INFO - Running setup.py install for requests 05:35:47 INFO - Running setup.py install for docopt 05:35:47 INFO - Successfully installed blobuploader requests docopt 05:35:47 INFO - Cleaning up... 05:35:47 INFO - Return code: 0 05:35:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:47 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 0x10a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13683b0>, '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 0x13692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1369740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', '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 05:35:47 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 05:35:47 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 05:35:47 INFO - Using env: {'DISPLAY': ':0', 05:35:47 INFO - 'HOME': '/home/cltbld', 05:35:47 INFO - 'LANG': 'en_US.UTF-8', 05:35:47 INFO - 'LANGUAGE': 'en_US:en', 05:35:47 INFO - 'LOGNAME': 'cltbld', 05:35:47 INFO - 'MAIL': '/var/mail/cltbld', 05:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:47 INFO - 'MOZ_NO_REMOTE': '1', 05:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:47 INFO - 'NO_EM_RESTART': '1', 05:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:47 INFO - 'PWD': '/builds/slave/test', 05:35:47 INFO - 'SHELL': '/bin/bash', 05:35:47 INFO - 'SHLVL': '1', 05:35:47 INFO - 'TERM': 'linux', 05:35:47 INFO - 'TMOUT': '86400', 05:35:47 INFO - 'USER': 'cltbld', 05:35:47 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', 05:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:47 INFO - '_': '/tools/buildbot/bin/python'} 05:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:47 INFO - Running setup.py (path:/tmp/pip-Ub5B9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:48 INFO - Running setup.py (path:/tmp/pip-qp9867-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:48 INFO - Running setup.py (path:/tmp/pip-MTvqZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:48 INFO - Running setup.py (path:/tmp/pip-o8ANG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:48 INFO - Running setup.py (path:/tmp/pip-Pkr_Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:48 INFO - Running setup.py (path:/tmp/pip-lIRUIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:48 INFO - Running setup.py (path:/tmp/pip-XpZ1hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:48 INFO - Running setup.py (path:/tmp/pip-ezdn7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:48 INFO - Running setup.py (path:/tmp/pip-WMdLY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:48 INFO - Running setup.py (path:/tmp/pip-HFtW6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:48 INFO - Running setup.py (path:/tmp/pip-HqIBrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:48 INFO - Running setup.py (path:/tmp/pip-IXswV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:48 INFO - Running setup.py (path:/tmp/pip-KntnzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:48 INFO - Running setup.py (path:/tmp/pip-Enp6yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:48 INFO - Running setup.py (path:/tmp/pip-jXVVLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:49 INFO - Running setup.py (path:/tmp/pip-vQn06M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:49 INFO - Running setup.py (path:/tmp/pip-TvwUJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:35:49 INFO - Running setup.py install for manifestparser 05:35:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:35:49 INFO - Running setup.py install for mozcrash 05:35:49 INFO - Running setup.py install for mozdebug 05:35:49 INFO - Running setup.py install for mozdevice 05:35:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:35:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:35:49 INFO - Running setup.py install for mozfile 05:35:49 INFO - Running setup.py install for mozhttpd 05:35:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:35:49 INFO - Running setup.py install for mozinfo 05:35:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:35:49 INFO - Running setup.py install for mozInstall 05:35:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:35:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:35:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:35:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:35:50 INFO - Running setup.py install for mozleak 05:35:50 INFO - Running setup.py install for mozlog 05:35:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:35:50 INFO - Running setup.py install for moznetwork 05:35:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:35:50 INFO - Running setup.py install for mozprocess 05:35:50 INFO - Running setup.py install for mozprofile 05:35:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:35:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:35:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:35:50 INFO - Running setup.py install for mozrunner 05:35:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:35:50 INFO - Running setup.py install for mozscreenshot 05:35:50 INFO - Running setup.py install for moztest 05:35:50 INFO - Running setup.py install for mozversion 05:35:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:35:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:35:50 INFO - Cleaning up... 05:35:50 INFO - Return code: 0 05:35:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:50 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 0x10a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13683b0>, '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 0x13692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1369740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', '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 05:35:51 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 05:35:51 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 05:35:51 INFO - Using env: {'DISPLAY': ':0', 05:35:51 INFO - 'HOME': '/home/cltbld', 05:35:51 INFO - 'LANG': 'en_US.UTF-8', 05:35:51 INFO - 'LANGUAGE': 'en_US:en', 05:35:51 INFO - 'LOGNAME': 'cltbld', 05:35:51 INFO - 'MAIL': '/var/mail/cltbld', 05:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:51 INFO - 'MOZ_NO_REMOTE': '1', 05:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:51 INFO - 'NO_EM_RESTART': '1', 05:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:51 INFO - 'PWD': '/builds/slave/test', 05:35:51 INFO - 'SHELL': '/bin/bash', 05:35:51 INFO - 'SHLVL': '1', 05:35:51 INFO - 'TERM': 'linux', 05:35:51 INFO - 'TMOUT': '86400', 05:35:51 INFO - 'USER': 'cltbld', 05:35:51 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', 05:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:51 INFO - '_': '/tools/buildbot/bin/python'} 05:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:51 INFO - Running setup.py (path:/tmp/pip-INeq4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:51 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)) 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:51 INFO - Running setup.py (path:/tmp/pip-kTzyjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:51 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)) 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:51 INFO - Running setup.py (path:/tmp/pip-vXnfNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:51 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)) 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:51 INFO - Running setup.py (path:/tmp/pip-tPRhcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:51 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)) 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:51 INFO - Running setup.py (path:/tmp/pip-RdZcpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:51 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)) 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:51 INFO - Running setup.py (path:/tmp/pip-FjuwzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:51 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)) 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:51 INFO - Running setup.py (path:/tmp/pip-L6TOsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:51 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)) 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:51 INFO - Running setup.py (path:/tmp/pip-JmBl1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:51 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)) 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:51 INFO - Running setup.py (path:/tmp/pip-DDuert-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:51 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)) 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:51 INFO - Running setup.py (path:/tmp/pip-OIzI9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:51 INFO - Running setup.py (path:/tmp/pip-w2IYYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:52 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)) 05:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:52 INFO - Running setup.py (path:/tmp/pip-3igbBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 05:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:52 INFO - Running setup.py (path:/tmp/pip-0yRlWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:52 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)) 05:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:52 INFO - Running setup.py (path:/tmp/pip-LH4cXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 05:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:52 INFO - Running setup.py (path:/tmp/pip-JwJHpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:52 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)) 05:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:52 INFO - Running setup.py (path:/tmp/pip-pKjrCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:52 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)) 05:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:52 INFO - Running setup.py (path:/tmp/pip-qNdFV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:54 INFO - Downloading blessings-1.6.tar.gz 05:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:35:54 INFO - Installing collected packages: blessings 05:35:54 INFO - Running setup.py install for blessings 05:35:54 INFO - Successfully installed blessings 05:35:54 INFO - Cleaning up... 05:35:54 INFO - Return code: 0 05:35:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:54 INFO - Reading from file tmpfile_stdout 05:35:54 INFO - Current package versions: 05:35:54 INFO - argparse == 1.2.1 05:35:54 INFO - blessings == 1.6 05:35:54 INFO - blobuploader == 1.2.4 05:35:54 INFO - docopt == 0.6.1 05:35:54 INFO - functools32 == 3.2.3-2 05:35:54 INFO - jsonschema == 2.5.1 05:35:54 INFO - manifestparser == 1.1 05:35:54 INFO - mozInstall == 1.12 05:35:54 INFO - mozcrash == 0.17 05:35:54 INFO - mozdebug == 0.1 05:35:54 INFO - mozdevice == 0.48 05:35:54 INFO - mozfile == 1.2 05:35:54 INFO - mozhttpd == 0.7 05:35:54 INFO - mozinfo == 0.9 05:35:54 INFO - mozleak == 0.1 05:35:54 INFO - mozlog == 3.2 05:35:54 INFO - moznetwork == 0.27 05:35:54 INFO - mozprocess == 0.22 05:35:54 INFO - mozprofile == 0.28 05:35:54 INFO - mozrunner == 6.11 05:35:54 INFO - mozscreenshot == 0.1 05:35:54 INFO - mozsystemmonitor == 0.3 05:35:54 INFO - moztest == 0.7 05:35:54 INFO - mozversion == 1.4 05:35:54 INFO - psutil == 3.1.1 05:35:54 INFO - requests == 1.2.3 05:35:54 INFO - wsgiref == 0.1.2 05:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:54 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 0x10a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13683b0>, '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 0x13692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1369740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', '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 05:35:54 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 05:35:54 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 05:35:54 INFO - Using env: {'DISPLAY': ':0', 05:35:54 INFO - 'HOME': '/home/cltbld', 05:35:54 INFO - 'LANG': 'en_US.UTF-8', 05:35:54 INFO - 'LANGUAGE': 'en_US:en', 05:35:54 INFO - 'LOGNAME': 'cltbld', 05:35:54 INFO - 'MAIL': '/var/mail/cltbld', 05:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:54 INFO - 'MOZ_NO_REMOTE': '1', 05:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:54 INFO - 'NO_EM_RESTART': '1', 05:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:54 INFO - 'PWD': '/builds/slave/test', 05:35:54 INFO - 'SHELL': '/bin/bash', 05:35:54 INFO - 'SHLVL': '1', 05:35:54 INFO - 'TERM': 'linux', 05:35:54 INFO - 'TMOUT': '86400', 05:35:54 INFO - 'USER': 'cltbld', 05:35:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', 05:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:54 INFO - '_': '/tools/buildbot/bin/python'} 05:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:55 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)) 05:35:55 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)) 05:35:55 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)) 05:35:55 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)) 05:35:55 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)) 05:35:55 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)) 05:35:55 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)) 05:35:55 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)) 05:35:55 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)) 05:35:55 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)) 05:35:55 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)) 05:35:55 INFO - Cleaning up... 05:35:55 INFO - Return code: 0 05:35:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:55 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 0x10a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13683b0>, '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 0x13692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1369740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', '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 05:35:55 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 05:35:55 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 05:35:55 INFO - Using env: {'DISPLAY': ':0', 05:35:55 INFO - 'HOME': '/home/cltbld', 05:35:55 INFO - 'LANG': 'en_US.UTF-8', 05:35:55 INFO - 'LANGUAGE': 'en_US:en', 05:35:55 INFO - 'LOGNAME': 'cltbld', 05:35:55 INFO - 'MAIL': '/var/mail/cltbld', 05:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:55 INFO - 'MOZ_NO_REMOTE': '1', 05:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:55 INFO - 'NO_EM_RESTART': '1', 05:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:55 INFO - 'PWD': '/builds/slave/test', 05:35:55 INFO - 'SHELL': '/bin/bash', 05:35:55 INFO - 'SHLVL': '1', 05:35:55 INFO - 'TERM': 'linux', 05:35:55 INFO - 'TMOUT': '86400', 05:35:55 INFO - 'USER': 'cltbld', 05:35:55 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', 05:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:55 INFO - '_': '/tools/buildbot/bin/python'} 05:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:35:55 INFO - Cleaning up... 05:35:55 INFO - Return code: 0 05:35:55 INFO - Running post-action listener: _resource_record_post_action 05:35:55 INFO - Running post-action listener: _start_resource_monitoring 05:35:55 INFO - Starting resource monitoring. 05:35:55 INFO - ##### 05:35:55 INFO - ##### Finished create-virtualenv step (success) 05:35:55 INFO - ##### 05:35:55 INFO - ##### 05:35:55 INFO - ##### Running install step. 05:35:55 INFO - ##### 05:35:55 INFO - Running pre-action listener: _resource_record_pre_action 05:35:55 INFO - Running main action method: install 05:35:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:55 INFO - Reading from file tmpfile_stdout 05:35:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:35:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:35:55 INFO - Reading from file tmpfile_stdout 05:35:55 INFO - Output received: 05:35:55 INFO - Usage: mozinstall [options] installer 05:35:55 INFO - Options: 05:35:55 INFO - -h, --help show this help message and exit 05:35:55 INFO - -d DEST, --destination=DEST 05:35:55 INFO - Directory to install application into. [default: 05:35:55 INFO - "/builds/slave/test"] 05:35:55 INFO - --app=APP Application being installed. [default: firefox] 05:35:55 INFO - mkdir: /builds/slave/test/build/application 05:35:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:36:11 INFO - Reading from file tmpfile_stdout 05:36:11 INFO - Output received: 05:36:11 INFO - /builds/slave/test/build/application/firefox/firefox 05:36:11 INFO - Running post-action listener: _resource_record_post_action 05:36:11 INFO - ##### 05:36:11 INFO - ##### Finished install step (success) 05:36:11 INFO - ##### 05:36:11 INFO - ##### 05:36:11 INFO - ##### Running run-tests step. 05:36:11 INFO - ##### 05:36:11 INFO - Running pre-action listener: _resource_record_pre_action 05:36:11 INFO - Running main action method: run_tests 05:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:36:11 INFO - Python 2.7.3 05:36:11 INFO - Return code: 0 05:36:11 INFO - grabbing minidump binary from tooltool 05:36:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:11 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 0x13683b0>, '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 0x13692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1369740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:36:11 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 05:36:11 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 05:36:11 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 05:36:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:11 INFO - Return code: 0 05:36:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:36:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:36:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:36:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:36:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 05:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 05:36:12 INFO - Using env: {'DISPLAY': ':0', 05:36:12 INFO - 'HOME': '/home/cltbld', 05:36:12 INFO - 'LANG': 'en_US.UTF-8', 05:36:12 INFO - 'LANGUAGE': 'en_US:en', 05:36:12 INFO - 'LOGNAME': 'cltbld', 05:36:12 INFO - 'MAIL': '/var/mail/cltbld', 05:36:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:36:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:12 INFO - 'MOZ_NO_REMOTE': '1', 05:36:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:12 INFO - 'NO_EM_RESTART': '1', 05:36:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:12 INFO - 'PWD': '/builds/slave/test', 05:36:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:36:12 INFO - 'SHELL': '/bin/bash', 05:36:12 INFO - 'SHLVL': '1', 05:36:12 INFO - 'TERM': 'linux', 05:36:12 INFO - 'TMOUT': '86400', 05:36:12 INFO - 'USER': 'cltbld', 05:36:12 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304', 05:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:12 INFO - '_': '/tools/buildbot/bin/python'} 05:36:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 05:36:12 INFO - mozversion application_buildid: 20160630050225 05:36:12 INFO - mozversion application_changeset: 4e695d4a3a8426bb41bebf29033ab826a572c8bd 05:36:12 INFO - mozversion application_display_name: Nightly 05:36:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:12 INFO - mozversion application_name: Firefox 05:36:12 INFO - mozversion application_remotingname: firefox 05:36:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:36:12 INFO - mozversion application_vendor: Mozilla 05:36:12 INFO - mozversion application_version: 50.0a1 05:36:12 INFO - mozversion platform_buildid: 20160630050225 05:36:12 INFO - mozversion platform_changeset: 4e695d4a3a8426bb41bebf29033ab826a572c8bd 05:36:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:36:12 INFO - mozversion platform_version: 50.0a1 05:36:12 INFO - using testdate: 1467290172 05:36:12 INFO - actual date: 1467290172 05:36:12 INFO - starting webserver on 'localhost:45002' 05:36:12 INFO - SUITE-START | Running 2 tests 05:36:12 INFO - TEST-START | dromaeo_css 05:36:12 INFO - operating with platform_type : linux_ 05:36:12 INFO - Initialising browser for dromaeo_css test... 05:36:12 INFO - TEST-INFO | started process 3279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE12XVX/profile http://localhost:45002/getInfo.html) 05:36:18 INFO - PROCESS | 3279 | __metrics Screen width/height:1600/1200 05:36:18 INFO - PROCESS | 3279 | colorDepth:24 05:36:18 INFO - PROCESS | 3279 | Browser inner width/height: 1024/697 05:36:18 INFO - PROCESS | 3279 | __metrics 05:36:19 INFO - PROCESS | 3279 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:20 INFO - TEST-INFO | 3279: exit 0 05:36:20 INFO - Browser initialized. 05:36:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:36:20 INFO - TEST-INFO | started process 3361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE12XVX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:32 INFO - PROCESS | 3361 | RSS: Main: 159350784 05:36:32 INFO - PROCESS | 3361 | 05:37:23 INFO - PROCESS | 3361 | 1467290243466 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] 05:39:36 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:45002/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45002/tests/dromaeo/cssquery-ext.html) 05:39:37 INFO - PROCESS | 3361 | RSS: Main: 269901824 05:39:37 INFO - PROCESS | 3361 | 05:42:40 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:45002/tests/dromaeo/cssquery-ext.html (next: http://localhost:45002/tests/dromaeo/cssquery-jquery.html) 05:42:41 INFO - PROCESS | 3361 | RSS: Main: 241287168 05:42:41 INFO - PROCESS | 3361 | 05:45:43 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:45002/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45002/tests/dromaeo/cssquery-mootools.html) 05:45:44 INFO - PROCESS | 3361 | RSS: Main: 241205248 05:45:44 INFO - PROCESS | 3361 | 05:48:46 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:45002/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45002/tests/dromaeo/cssquery-prototype.html) 05:48:46 INFO - PROCESS | 3361 | RSS: Main: 236826624 05:48:46 INFO - PROCESS | 3361 | 05:51:49 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:45002/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45002/tests/dromaeo/cssquery-yui.html) 05:51:50 INFO - PROCESS | 3361 | RSS: Main: 215023616 05:51:50 INFO - PROCESS | 3361 | 05:54:53 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:45002/tests/dromaeo/cssquery-yui.html (next: http://localhost:45002/tests/dromaeo/cssquery-dojo.html) 05:54:53 INFO - PROCESS | 3361 | RSS: Main: 302383104 05:54:53 INFO - PROCESS | 3361 | 05:54:53 INFO - PROCESS | 3361 | __start_tp_report 05:54:53 INFO - PROCESS | 3361 | _x_x_mozilla_page_load 05:54:53 INFO - PROCESS | 3361 | _x_x_mozilla_page_load_details 05:54:53 INFO - PROCESS | 3361 | |i|pagename|runs| 05:54:53 INFO - PROCESS | 3361 | |0;dojo.html;2629.8553579553127;2631.4342416380473;2659.614355918391;2669.4394177222784;2674.277944954862;4656.5110663380365;4711.458182309036;4724.173269677805;4779.16364636189;4822.686525375848;4689.202835517962;4746.24060150376;4746.359241502405;4766.761661916899;4778.784954677039;4308.0952999869905;4310.4611923509565;4360.956390436087;4388.912221755563;4583.083383323332;4463.218936686067;4480.126375356806;4495.640348772106;4496.842610508633;4514.909701805962;4312.9137417251795;4317.568243175658;4347.0653809430805;4352.455943007124;4386.8025938832825;4320.1575692739925;4329.480462344539;4332.068605249855;4413.867583972486;4438.045820148684;4327.8052487637815;4349.238883195429;4356.978215108904;4391.099824535962;4398.516163222043;4689.88275293117;4700.529947005306;4732.053589282123;4771.33201351811;4811.278308253755;5158.92261616076;5163.793448262065;5177.171652535576;5180.041692286939;5180.326557547494;5173.456787037345;5196.792128314863;5209.765560549784;5211.24436956643;5216.426193118754;4683.578477937002;4757.119932812371;4786;4793.784279707422;4797.640176986775;5242.842714718565;5248.711320877388;5297.337832770903;5301.416844147141;5315.920261196085;5056.367954005749;5059.797608095709;5080.339555857715;5093.312402825645;5109.897802043938;5000.64995450315;5054.54509094176;5059.038782631288;5124.231365295235;5124.590032797368;5106.923396149061;5140.794368225229;5173.275741396207;5182.404023537266;5229.973850130725;5139.229115632685;5159.17453207485;5160.200168973815;5169.870753231199;5211.557017653542;4247.851325203603;4284.935725964113;4391.209582275221;4438.489573699001;4441.977790111094;3847.2882516734494;3847.9995201247875;3856.46009558662;3887.941680874789;3929.0766669832565;4437.556244375537;4450.621697155778;4452.354408610733;4493.707908985905;4496.662750293741;4968.378952630921;5045.84862454127;5172.353455818023;5221.947780522222;5286.07493688603;4454.309582014793;4457.888552786207;4476.70901391415;4518.9832287735;4533.750643714561;4674.392328997209;4686.133065382915;4687;4688.718676879398;4735.147673418817;4750.358701575243;4785;4824.469308376006;4895.094407534689;4903.8528844134735;5179.533841954242;5198.06434841717;5199.29809475716;5200.245964335075;5242.082635538689;4845.297431872429;4851.1753001990455;4859.149648811514;4860.198067318853;4907.092187945242;4973;5060.797568097235;5072.9746351268;5099.5410413063;5128.564072053917;5196.064708352533;5198.766055527586;5211.71335576547;5221.4517475666025;5223.7910483580235;5034.043531728959;5062.240663900445;5074.11203039474;5080.491950805038;5116.462771408948;4848.296996935495;4918.852434426973;4954.108260513142;4971.37857767779;5002.2496625506465;4868.2210846264425;4885.267209918398;4897.608191344612;4909.852704418873;4936.531029552187;4902.044101400193;4998.575121114746;5000.399952005782;5009.7996080157845;5017.774200161075;4796.448408432935;4840.128776820206;4856.295837103671;4907.067657145131;4907.779149938333 05:54:53 INFO - PROCESS | 3361 | |1;ext.html;531.300636739165;578.7540295374467;592.2774215457141;592.7658574862932;592.9080992446171;26865.731342686566;39726.2054758905;40815.387769183486;40841.18317633645;40956.38565421521;40166.397504037464;40323.79838100813;40332.193356132935;40377;40409.39385909214;7643.61781910905;7781;7921.841563168733;7928.722494712686;7931.087924888654;7563.924360756377;7804.765857024298;7812.49218800779;9987;10292.382457052563;10260.435676037814;10270.486475676187;10338.276320657556;10349.741256468611;10356.119729822974;10194.796104077914;10247.948760256226;10256.128229100535;10264.281500294983;10276.537555810006;7589.582572958485;9964.402135871798;10349.534270957825;10359.27485076045;10361.171106311476;37144.25711485782;37548;37599.62400376016;40584.39123413151;40698.79650601728;3201.247706788926;3281.737461003114;3297.142742886843;3435.7594968352223;3642.071271825694;30548.69451305481;32351.51472727911;32791.50812737811;32885.50671739926;33065.50401743976;3331.9666803331897;3347.196672798535;3368.292658541685;3369.6630336966355;3412.095794614429;273112;276491.3508649119;277184;277458;277728;58655.41344586585;59039.704801476575;59116.40883591195;59153.704231478565;59352.40647593555;34433;35304.823475882455;35556.64443355533;37923;64090.359096408436;14827.258637068104;14915.552533424014;15055.397784088733;15058.472953446577;15088.54734357971;9345.112214339626;11000.339979601249;11003.504842282116;11130.944345278222;11134.888651113548;19533.413997580094;19774.40676779699;19930.20279188816;20811.271605493734;20862.687059694115;7355.5586664800285;7497.700091996259;7549.773506794805;7611.65747541362;7779.416543759241;808.3533173461325;906.4515967839494;907.773056735816;914.6524320758069;985.1232403161192;28415.289617759307;28808.567871481944;29266.046870823215;29274.853625731736;29598.852005740264;969.3892847506168;973.026973026973;979.0601023017982;983.1578635337379;1083.4041277297456;15240.3903843845;15291;15422;15634.905556611155;16296.83703162977;422903;424725;425494;427778;427844;49994;50816.49183508191;50892.236616450784;50962;51092;1100.8238681811033;1126.1947707389093;1128.3963079752293;1234.5493894728538;1244.7883859743683;21908.561828763653;28983.275418114717;29389.559156613097;31306.379388669215;31644.841775790974;45745.54254457546;46575.301370478795;46903.76548117238;46970.53029469798;46990;371942;373915;375079;375461;376619;25627.10305139311;25967.61048584235;41494;42497;43009.3548596765;40682.38976415297;44269.33595995998;44446.55553444424;44648;45236;37699.29124381566;38173.23653526858;38257;38974;39374.60625393709;38143;38839.41740873833;38842.805785970886;39009.41485877771;39390.80304598458;37726.62273377231;38490.422643660924;38526;38789.806050969564;38812.223755525294;32889.50665739968;34513;34543;34658.51375306184;34691.65308346985;26270.474590508464;26352.20943371702;26373.60439593446;26549.203523894314;26960.595591065758 05:54:53 INFO - PROCESS | 3361 | |2;jquery.html;351.84342967379496;372.48038985615057;372.72045965525854;374.7152164355091;392.9332013557695;13169.209847409162;16764.664706705873;16908.323667053333;17525.73711394327;18337.266509339643;15733.763993540106;15972.920135399336;16117.516474505783;17305.567360815956;17797.288108475645;4517.503074661785;5084.745762711868;5281.577473802086;5286.3392075990505;5289.418164001957;5129.0767661820855;5172.715500647463;5189.584833213334;5193.324867767204;5193.584513238932;5032.345795046657;5108.412532558747;5177.249298851664;5189.818356357509;5227.817026404076;5128.102582048145;5134.255532947739;5145.048166089286;5148.562372198349;5152.149895267314;4621.4685311189305;4746.620270378361;5051.292819005343;5057.443681195103;5113.411957624883;12517.937410312981;12614.684632884251;12677.873221267762;12711.74576508474;12829.807552886714;1938.5347516596057;1978.9505262368411;1988.7911769264163;1995.800419958007;2489.265666628349;9047.728568142966;9209.401388909766;9262.6294948202;9660.516974151264;9716.93113757486;1675.6229848284038;1691.2812054876752;1693.068812153323;1693.8644908407298;1708.2312959168423;69061.309386906;75111.62444187798;76228.61885690536;76304;77819;8831.116888311117;9502.667406640734;9892.208623310118;10409.219308551888;10563;12928.159669621444;13842.515511957034;13844.723105537832;14329.57011289663;14384.496542620958;7322.597257150801;7378.897014350884;7411.518251313647;7469.1037075551285;7531.096268447822;7209.89185162223;7228.96385518069;7291.270872912773;7338.376238019721;7438;4412.536683648171;4441.555844415532;4476.798544065525;4554.407926969473;4590.472095709036;1812.3475548802421;1858.990705046493;1869.7008478643625;1877.3710806879576;1966.7049942508452;843.1147295339869;868.1275318305189;887.4630848336792;920.8296465153834;926.2589928057662;17130.799179718786;17311.826881731275;17348;18007.369742058963;18181.272749090153;809.7408829174608;816.8529664660299;863.5336918064176;874.6807415293499;911.1753862754218;9680.419174849532;9794.118529332394;10034.996500349907;10049.447280399649;10174.03346682064;394240;400225;400739;401935;403342;79371;83705;85371;85731;85794.57102714447;874.1224743791635;881.4270724029304;900.3652425040331;903.0878812399524;909.53159123053;15568.610784730472;15709.45016924402;15820.28808703634;15946.202689865693;16238.188090595659;38160.80919595496;39271;39420.81737547878;40350.798246008584;40362;54060;54596.72701636466;55666;55730.72134639301;56074;7593.658285377061;7759.4568380215105;7791.649375778217;7863.174366691415;7936.523808571505;8505.532195729294;10858.402787846428;11594.47824847867;11736.770013697711;11980.880191198325;9973.50132493387;10228.846567301645;10283.84574231402;10462.738431538968;10575.101116405192;9829.655962041294;10314.071733544017;10509.842352364567;10556.84164737545;10677.9466102669;9659.758506037406;9661.13049825519;9728;10045.246606504688;10158.339707918962;7694.461387702807;7736.303732664087;7753.689852405841;7888.566128862968;7964.442489025712;9093;9388.295877809054;9757.853632195382;9801;9982.900170998197 05:54:53 INFO - PROCESS | 3361 | |3;mootools.html;1225.8774122587747;1390.8539603341649;1441.4450436581917;1517.946871859485;1734.340950438833;7353.1911489736085;7671.69313227471;7696.345810606092;7895.486793358442;7901.604919754018;7661.731839385623;7802.531848089118;7805.297523222909;7809.492382995116;7823.374130069595;2206.1396055538353;2235.5305385868987;2236.944076398087;2243.921462748804;2246.696695946051;2106.820920221783;2108.873467591942;2115;2145.839062070343;2219.83351248657;2157.3635777445693;2169.457635591102;2183.094015983365;2198.087793565668;2201.5046614511766;2141;2156.0836644426136;2156.471664442206;2159.6220661384273;2162.664786958024;2096.9056392462376;2121.6499277619173;2125.8724476531456;2132.477543001959;2138.5615948730474;7711.498752581064;7728.536287822749;7745.496542724762;7794.142644309121;8033.598320084031;4461.57615026572;4552.430946131733;4559.703619264737;4561.543845615445;4577.56513131252;2865.28367908023;2940.794144409892;3014.216303761038;3014.608100946863;3019.0791808498398;987.6938149173707;994.3636072913341;1004.5328922051208;1009.2027298434228;1016.7153197104823;10854.511546980404;10953.123750099972;10972.122230221563;10979.396133212671;10990.505427255714;4042.8584999525465;4256.404103425523;4402.0755641315045;4415.205263052617;4473.776311184492;8823.294136469067;8915.955420222857;8921.910780892107;8931.106889311146;8936.776580585407;4590.747508886977;4604.171249175113;4610.170169369479;4615.123126605934;4616.6537509686905;3472.2361080562237;3626.2022355082368;4108.609682080198;4276.786160691953;4277;3401.064707205489;3418.1967237699123;3427.9828600857336;3450.4996775467916;3480.686738193524;1014.2342531388902;1036.6475398364441;1043.3739756146251;1045.1899777672213;1051.2641151194196;829.1459796409587;840.4705035827512;845.8984921809299;863.7538301584018;886.2821114896955;5103.157978933435;5243.397009343974;5260.500252476085;5334.333208348957;5388.164834450667;417.18232264761406;419.6747520671504;425.48728781817834;425.63608115061174;430.01741021765116;3523.753337266418;3715.777053376806;3716.2753263113973;3723.925521489555;3738.12154143776;9639.662611808553;10183.898161018444;10186.847197292047;10193.286469947032;10197.592096316213;9973.80052398948;10042.497875106215;10053.095221430107;10064.44645544502;10071.093601575747;7076.044733960953;7145.92854071463;7149.356557909813;7152.070230869954;7153.785386438415;5049.798008079636;5083.186690129562;5106.872328191825;5178.741062946913;5197.038547868657;9287.34988550822;9290.72127836166;9316.161545460942;9334;9370.062993700576;9175.036621154683;9708.951455242679;9717.12545870875;9723.56243969009;9737;5802.564807639359;5961.880762384815;5978.103284507185;6119;6122.602030867979;7464.253574642492;7727.150013498623;7735.110462296908;7919.564423956737;7930.762077137695;6959.547629404275;7034.261402552658;7126.643667816485;7179.497435179696;7187.892181617175;6806.55757375769;6875.346842049998;6893.414059804973;6988.091548098715;7008.789736307919;5983.521318294613;6101.176341193882;6104.023356262976;6105.603135796159;6111.877762444815;4481.7535035573355;4509.0080182359825;4539.137563862855;4567.132244873596;4609.032103258353;4511.300748384006;4541.341505481752;4627.745473998963;4660.184467718203;4708.434987801349 05:54:53 INFO - PROCESS | 3361 | |4;prototype.html;286.3620093067653;293.3121829310267;298.1071690287589;304.5857633618279;306.78218464889926;4800.447948485921;4865.513448655132;4872.293517439969;4879.414470263565;4890.413150421954;4800.49594792547;4801.567858892699;4806.086843499741;4809.759512024402;4815.446223684277;3588.1926566522584;3646.3618866698353;3704.6663201247666;3765.058735316171;3810;3763.5860055393887;3777.5655799582987;3779.2063666630042;3787.9431808522895;3795.2978698940647;3564.910877228077;3745.9250814983684;3747.4704574412162;3748.306563285801;3748.887533374003;3636.436352365374;3757.8121093945465;3764.171882185915;3765.755225910321;3773.64150405711;3315.61870384904;3326.750493712957;3335.7498187636024;3338.8314090068525;3345.6821601947777;4660.834791302174;4676.602488788457;4685.133250348662;4698.238160689742;4699.673661537527;4169.749815011109;4265.893352666177;4281.914361712779;4358.782060896974;4359.520452750195;5047.671901326402;5059.2916991621205;5059.772310246048;5061.582756828094;5062;3688.0964163780045;3690.132818787583;3691.7600355977042;3696.8336424860945;3697.5949139326885;4990.975045124787;5266.368035835724;5281.551068159211;5287.629865909388;5291.656042357235;3614.6385361463645;3630.237650093457;3630.673239408466;3635.5092062571744;3643.5425829668343;3679.5768486623847;3683.594804571495;3684.889453316405;3685.244524872395;3698.7992144673876;4218.282891908321;4222.451081359403;4228.133232687292;4245.80893859777;4250.192463431938;4819.156647586658;5094.77073531692;5103.234514822732;5103.744812759422;5104.366602687104;1270.0411189551828;1276.6361586947676;1279.309173046563;1281.7756892543769;1282.2819221235952;815.2540425510709;815.6166601697192;842.5045544159044;853.6542700206427;860.9827803443897;4402.163588918095;4409.250427427345;4414.205443020287;4449.466064072332;4460.643148548108;5174.741262936914;5176.663516871391;5185.433210560796;5188.143956247252;5190.506901844319;4260.936085958713;4426.291793313055;4446.9777651111535;4446.9777651111535;4459.130469558405;2746.491898998652;2750.8349499030123;2762.7513523782955;2763.2677340504783;2770.5428604280473;4804.375431193923;4811.326414302001;4812.855614331575;4821.445533763592;4826.262545483623;5092.911906118474;5154.9484505155215;5230.320058392384;5244.187150991603;5281.709505977131;4811.735354555463;4821.841693690638;4854.927176092361;4861.611071114302;4866.6350023747655;5126.384833819965;5134.178531434953;5138.280640710378;5141.7686204120155;5166.354205724285;4852.466228714768;5071.87320316995;5073.771680274471;5076.883085721135;5081.923771143362;4818;4837.234409440599;4839.491853355347;4848.763565290828;4861.927071093865;3633.563972323338;3637.2907283079544;3646.489491471249;3648.142686468731;3652.4886515887265;4869.342638743866;5074.771635276347;5152.27868098474;5158.845234642967;5191.974040129775;5078.187490001582;5084.720340381315;5085.389753229636;5101.132807422821;5114.488551144856;5091.974540127424;5099;5102.974485127699;5106.438291787975;5107.463716309734;4790.568848803624;4982.978489409735;4985.6011519077665;4992.600591952562;4996.550310472075;4855.635827312895;4980.5019498049905;5095.87260318495;5122.206058061007;5125.461826508163;4977.228529577921;4990.700557966534;4998.6500944933505;5003.199488081889;5011.473795251446 05:54:53 INFO - PROCESS | 3361 | |5;yui.html;637.6365471681142;669.8224970382853;677.3971165662564;685.6160550091948;706.0100474490532;12361.876381236185;12697.619071427873;12711.919486843617;12716.427760750777;12725.30010849403;12444.937775311133;12698.238105713664;12702.110852240347;12713.427895744691;12761.936190319058;632.7975047984647;774.5701135869605;783.561205724796;788.4008153803094;791.3550456378063;797.5972134072285;814.3322475570035;814.4868732698392;816.6692489541745;816.9918300816976;858.3004851046409;861.9525926074064;862.8835107260534;863.0549548244662;863.7322430046675;666.6233578028398;812.4678335690132;843.3000609494105;856.1780690537092;856.6787454704486;622.0700053420165;622.8007037747923;623.0436280309702;623.7349126621168;623.840920565253;13098.672533186651;13107.672308192372;13121;13130.343482825916;13145.474181032747;11744.647660570197;11882.702932426671;12276.32480213588;12425.875741242562;12619.43212555428;9882.9505852471;9905.405675659484;10064.345817521911;10350.068493835515;11011.394373309466;4273.9358909616385;4314.3528470729325;4358.5205627380965;4448.243798554221;4449.310356894686;62160.68919655418;62612;63345.36654633441;63943;63959;10565.39006526035;10715.624953126604;10727.249092563447;10759.677209683721;11125.332480051224;18641.81358186428;18651.533711657317;18665;18692.252309907723;18943.43169704911;6681.866362672719;6719.395254427125;6793.184817821893;6849.212340580797;6893.827654308682;3646.3072016316814;3652.5251717277115;3661.7253705972157;3739.7569158004644;3747.5690295616355;2851.087651951356;2928.2093834664947;2938.30949726814;2940.529515277588;2942.3526824098662;511.3046257090354;514.765781569385;515.6828550441527;516.6693316277585;530.6391653675538;472.6195412692815;551.7778121460983;562.4965655738173;567.3532173322416;575.7639367859241;7802.570858602718;7910.683572657029;7998.320142787812;8044.4368894178015;8490.872636910452;503.5468078729173;532.9360476742816;543.5407081016534;580.5587753307517;605.5428151745404;3756.323861704919;3868.845246190121;3876.9224615507533;3882.825272862728;4335.479742430928;57962.4203757957;80435;103401.48299258456;106427;106716;53323.733381332844;82393;86352.56823715841;86951.56524217338;88248.5587572071;78110.60944695353;80041;80300.19699803044;81603.10381377136;83060;8458.915410845813;8530.658773648984;8533.914660853561;8600.354973377147;8727.214550690469;45608.54391456043;45673.77163114163;45967.77016114898;46105.30842037305;46572.76713616546;66463.66768166129;69094;70226;70251.29748702448;70795.29204708093;11439.828402573801;11476.483558240066;11604.375387445933;11604.767904642029;12187.085968552217;13826.82188799628;14224.573262802132;14316.355763990437;14447.349869256119;14517.201553914636;11749.88250117488;11856.34790086519;12176.695582610506;12282.219078233427;12425.62723118308;12713.491460341484;12779.349714569373;13015.219086854819;13066.281354525212;13347.132436391603;12050.337231452355;12054.457549410123;12341.568045118378;12913.806292905801;12968.805467918177;9938.45338506389;10216.948915255674;10251.641192558225;10752.193585480964;10772.138228941509;9223.538823058687;9612.279079069238;9654.179394751525;9733;9775.217982561237 05:54:53 INFO - PROCESS | 3361 | __end_tp_report 05:54:53 INFO - PROCESS | 3361 | __start_cc_report 05:54:53 INFO - PROCESS | 3361 | _x_x_mozilla_cycle_collect,1077 05:54:53 INFO - PROCESS | 3361 | __end_cc_report 05:54:53 INFO - PROCESS | 3361 | __startTimestamp1467291293517__endTimestamp 05:54:53 INFO - PROCESS | 3361 | 05:54:53 INFO - PROCESS | 3361 | ------- Summary: start ------- 05:54:53 INFO - PROCESS | 3361 | Number of tests: 6 05:54:53 INFO - PROCESS | 3361 | 05:54:53 INFO - PROCESS | 3361 | [#0] dojo.html Cycles:165 Average:4748.43 Median:4851.18 stddev:504.24 (10.4%) stddev-sans-first:477.61 05:54:53 INFO - PROCESS | 3361 | Values: 2629.9 2631.4 2659.6 2669.4 2674.3 4656.5 4711.5 4724.2 4779.2 4822.7 4689.2 4746.2 4746.4 4766.8 4778.8 4308.1 4310.5 4361.0 4388.9 4583.1 4463.2 4480.1 4495.6 4496.8 4514.9 4312.9 4317.6 4347.1 4352.5 4386.8 4320.2 4329.5 4332.1 4413.9 4438.0 4327.8 4349.2 4357.0 4391.1 4398.5 4689.9 4700.5 4732.1 4771.3 4811.3 5158.9 5163.8 5177.2 5180.0 5180.3 5173.5 5196.8 5209.8 5211.2 5216.4 4683.6 4757.1 4786.0 4793.8 4797.6 5242.8 5248.7 5297.3 5301.4 5315.9 5056.4 5059.8 5080.3 5093.3 5109.9 5000.6 5054.5 5059.0 5124.2 5124.6 5106.9 5140.8 5173.3 5182.4 5230.0 5139.2 5159.2 5160.2 5169.9 5211.6 4247.9 4284.9 4391.2 4438.5 4442.0 3847.3 3848.0 3856.5 3887.9 3929.1 4437.6 4450.6 4452.4 4493.7 4496.7 4968.4 5045.8 5172.4 5221.9 5286.1 4454.3 4457.9 4476.7 4519.0 4533.8 4674.4 4686.1 4687.0 4688.7 4735.1 4750.4 4785.0 4824.5 4895.1 4903.9 5179.5 5198.1 5199.3 5200.2 5242.1 4845.3 4851.2 4859.1 4860.2 4907.1 4973.0 5060.8 5073.0 5099.5 5128.6 5196.1 5198.8 5211.7 5221.5 5223.8 5034.0 5062.2 5074.1 5080.5 5116.5 4848.3 4918.9 4954.1 4971.4 5002.2 4868.2 4885.3 4897.6 4909.9 4936.5 4902.0 4998.6 5000.4 5009.8 5017.8 4796.4 4840.1 4856.3 4907.1 4907.8 05:54:53 INFO - PROCESS | 3361 | 05:54:53 INFO - PROCESS | 3361 | [#1] ext.html Cycles:180 Average:51776.85 Median:37573.81 stddev:96012.60 (255.5%) stddev-sans-first:96204.84 05:54:53 INFO - PROCESS | 3361 | Values: 531.3 578.8 592.3 592.8 592.9 26865.7 39726.2 40815.4 40841.2 40956.4 40166.4 40323.8 40332.2 40377.0 40409.4 7643.6 7781.0 7921.8 7928.7 7931.1 7563.9 7804.8 7812.5 9987.0 10292.4 10260.4 10270.5 10338.3 10349.7 10356.1 10194.8 10247.9 10256.1 10264.3 10276.5 7589.6 9964.4 10349.5 10359.3 10361.2 37144.3 37548.0 37599.6 40584.4 40698.8 3201.2 3281.7 3297.1 3435.8 3642.1 30548.7 32351.5 32791.5 32885.5 33065.5 3332.0 3347.2 3368.3 3369.7 3412.1 273112.0 276491.4 277184.0 277458.0 277728.0 58655.4 59039.7 59116.4 59153.7 59352.4 34433.0 35304.8 35556.6 37923.0 64090.4 14827.3 14915.6 15055.4 15058.5 15088.5 9345.1 11000.3 11003.5 11130.9 11134.9 19533.4 19774.4 19930.2 20811.3 20862.7 7355.6 7497.7 7549.8 7611.7 7779.4 808.4 906.5 907.8 914.7 985.1 28415.3 28808.6 29266.0 29274.9 29598.9 969.4 973.0 979.1 983.2 1083.4 15240.4 15291.0 15422.0 15634.9 16296.8 422903.0 424725.0 425494.0 427778.0 427844.0 49994.0 50816.5 50892.2 50962.0 51092.0 1100.8 1126.2 1128.4 1234.5 1244.8 21908.6 28983.3 29389.6 31306.4 31644.8 45745.5 46575.3 46903.8 46970.5 46990.0 371942.0 373915.0 375079.0 375461.0 376619.0 25627.1 25967.6 41494.0 42497.0 43009.4 40682.4 44269.3 44446.6 44648.0 45236.0 37699.3 38173.2 38257.0 38974.0 39374.6 38143.0 38839.4 38842.8 39009.4 39390.8 37726.6 38490.4 38526.0 38789.8 38812.2 32889.5 34513.0 34543.0 34658.5 34691.7 26270.5 26352.2 26373.6 26549.2 26960.6 05:54:53 INFO - PROCESS | 3361 | 05:54:53 INFO - PROCESS | 3361 | [#2] jquery.html Cycles:180 Average:24889.90 Median:5096.58 stddev:66380.28 (1302.4%) stddev-sans-first:66540.92 05:54:53 INFO - PROCESS | 3361 | Values: 351.8 372.5 372.7 374.7 392.9 13169.2 16764.7 16908.3 17525.7 18337.3 15733.8 15972.9 16117.5 17305.6 17797.3 4517.5 5084.7 5281.6 5286.3 5289.4 5129.1 5172.7 5189.6 5193.3 5193.6 5032.3 5108.4 5177.2 5189.8 5227.8 5128.1 5134.3 5145.0 5148.6 5152.1 4621.5 4746.6 5051.3 5057.4 5113.4 12517.9 12614.7 12677.9 12711.7 12829.8 1938.5 1979.0 1988.8 1995.8 2489.3 9047.7 9209.4 9262.6 9660.5 9716.9 1675.6 1691.3 1693.1 1693.9 1708.2 69061.3 75111.6 76228.6 76304.0 77819.0 8831.1 9502.7 9892.2 10409.2 10563.0 12928.2 13842.5 13844.7 14329.6 14384.5 7322.6 7378.9 7411.5 7469.1 7531.1 7209.9 7229.0 7291.3 7338.4 7438.0 4412.5 4441.6 4476.8 4554.4 4590.5 1812.3 1859.0 1869.7 1877.4 1966.7 843.1 868.1 887.5 920.8 926.3 17130.8 17311.8 17348.0 18007.4 18181.3 809.7 816.9 863.5 874.7 911.2 9680.4 9794.1 10035.0 10049.4 10174.0 394240.0 400225.0 400739.0 401935.0 403342.0 79371.0 83705.0 85371.0 85731.0 85794.6 874.1 881.4 900.4 903.1 909.5 15568.6 15709.5 15820.3 15946.2 16238.2 38160.8 39271.0 39420.8 40350.8 40362.0 54060.0 54596.7 55666.0 55730.7 56074.0 7593.7 7759.5 7791.6 7863.2 7936.5 8505.5 10858.4 11594.5 11736.8 11980.9 9973.5 10228.8 10283.8 10462.7 10575.1 9829.7 10314.1 10509.8 10556.8 10677.9 9659.8 9661.1 9728.0 10045.2 10158.3 7694.5 7736.3 7753.7 7888.6 7964.4 9093.0 9388.3 9757.9 9801.0 9982.9 05:54:53 INFO - PROCESS | 3361 | 05:54:53 INFO - PROCESS | 3361 | [#3] mootools.html Cycles:180 Average:5162.21 Median:4572.35 stddev:2988.40 (65.4%) stddev-sans-first:2982.14 05:54:53 INFO - PROCESS | 3361 | Values: 1225.9 1390.9 1441.4 1517.9 1734.3 7353.2 7671.7 7696.3 7895.5 7901.6 7661.7 7802.5 7805.3 7809.5 7823.4 2206.1 2235.5 2236.9 2243.9 2246.7 2106.8 2108.9 2115.0 2145.8 2219.8 2157.4 2169.5 2183.1 2198.1 2201.5 2141.0 2156.1 2156.5 2159.6 2162.7 2096.9 2121.6 2125.9 2132.5 2138.6 7711.5 7728.5 7745.5 7794.1 8033.6 4461.6 4552.4 4559.7 4561.5 4577.6 2865.3 2940.8 3014.2 3014.6 3019.1 987.7 994.4 1004.5 1009.2 1016.7 10854.5 10953.1 10972.1 10979.4 10990.5 4042.9 4256.4 4402.1 4415.2 4473.8 8823.3 8916.0 8921.9 8931.1 8936.8 4590.7 4604.2 4610.2 4615.1 4616.7 3472.2 3626.2 4108.6 4276.8 4277.0 3401.1 3418.2 3428.0 3450.5 3480.7 1014.2 1036.6 1043.4 1045.2 1051.3 829.1 840.5 845.9 863.8 886.3 5103.2 5243.4 5260.5 5334.3 5388.2 417.2 419.7 425.5 425.6 430.0 3523.8 3715.8 3716.3 3723.9 3738.1 9639.7 10183.9 10186.8 10193.3 10197.6 9973.8 10042.5 10053.1 10064.4 10071.1 7076.0 7145.9 7149.4 7152.1 7153.8 5049.8 5083.2 5106.9 5178.7 5197.0 9287.3 9290.7 9316.2 9334.0 9370.1 9175.0 9709.0 9717.1 9723.6 9737.0 5802.6 5961.9 5978.1 6119.0 6122.6 7464.3 7727.2 7735.1 7919.6 7930.8 6959.5 7034.3 7126.6 7179.5 7187.9 6806.6 6875.3 6893.4 6988.1 7008.8 5983.5 6101.2 6104.0 6105.6 6111.9 4481.8 4509.0 4539.1 4567.1 4609.0 4511.3 4541.3 4627.7 4660.2 4708.4 05:54:53 INFO - PROCESS | 3361 | 05:54:53 INFO - PROCESS | 3361 | [#4] prototype.html Cycles:180 Average:4179.15 Median:4807.92 stddev:1213.27 (25.2%) stddev-sans-first:1180.97 05:54:53 INFO - PROCESS | 3361 | Values: 286.4 293.3 298.1 304.6 306.8 4800.4 4865.5 4872.3 4879.4 4890.4 4800.5 4801.6 4806.1 4809.8 4815.4 3588.2 3646.4 3704.7 3765.1 3810.0 3763.6 3777.6 3779.2 3787.9 3795.3 3564.9 3745.9 3747.5 3748.3 3748.9 3636.4 3757.8 3764.2 3765.8 3773.6 3315.6 3326.8 3335.7 3338.8 3345.7 4660.8 4676.6 4685.1 4698.2 4699.7 4169.7 4265.9 4281.9 4358.8 4359.5 5047.7 5059.3 5059.8 5061.6 5062.0 3688.1 3690.1 3691.8 3696.8 3697.6 4991.0 5266.4 5281.6 5287.6 5291.7 3614.6 3630.2 3630.7 3635.5 3643.5 3679.6 3683.6 3684.9 3685.2 3698.8 4218.3 4222.5 4228.1 4245.8 4250.2 4819.2 5094.8 5103.2 5103.7 5104.4 1270.0 1276.6 1279.3 1281.8 1282.3 815.3 815.6 842.5 853.7 861.0 4402.2 4409.3 4414.2 4449.5 4460.6 5174.7 5176.7 5185.4 5188.1 5190.5 4260.9 4426.3 4447.0 4447.0 4459.1 2746.5 2750.8 2762.8 2763.3 2770.5 4804.4 4811.3 4812.9 4821.4 4826.3 5092.9 5154.9 5230.3 5244.2 5281.7 4811.7 4821.8 4854.9 4861.6 4866.6 5126.4 5134.2 5138.3 5141.8 5166.4 4852.5 5071.9 5073.8 5076.9 5081.9 4818.0 4837.2 4839.5 4848.8 4861.9 3633.6 3637.3 3646.5 3648.1 3652.5 4869.3 5074.8 5152.3 5158.8 5192.0 5078.2 5084.7 5085.4 5101.1 5114.5 5092.0 5099.0 5103.0 5106.4 5107.5 4790.6 4983.0 4985.6 4992.6 4996.6 4855.6 4980.5 5095.9 5122.2 5125.5 4977.2 4990.7 4998.7 5003.2 5011.5 05:54:53 INFO - PROCESS | 3361 | 05:54:53 INFO - PROCESS | 3361 | [#5] yui.html Cycles:180 Average:17997.83 Median:488.08 stddev:25549.43 (5234.6%) stddev-sans-first:25587.85 05:54:53 INFO - PROCESS | 3361 | Values: 637.6 669.8 677.4 685.6 706.0 12361.9 12697.6 12711.9 12716.4 12725.3 12444.9 12698.2 12702.1 12713.4 12761.9 632.8 774.6 783.6 788.4 791.4 797.6 814.3 814.5 816.7 817.0 858.3 862.0 862.9 863.1 863.7 666.6 812.5 843.3 856.2 856.7 622.1 622.8 623.0 623.7 623.8 13098.7 13107.7 13121.0 13130.3 13145.5 11744.6 11882.7 12276.3 12425.9 12619.4 9883.0 9905.4 10064.3 10350.1 11011.4 4273.9 4314.4 4358.5 4448.2 4449.3 62160.7 62612.0 63345.4 63943.0 63959.0 10565.4 10715.6 10727.2 10759.7 11125.3 18641.8 18651.5 18665.0 18692.3 18943.4 6681.9 6719.4 6793.2 6849.2 6893.8 3646.3 3652.5 3661.7 3739.8 3747.6 2851.1 2928.2 2938.3 2940.5 2942.4 511.3 514.8 515.7 516.7 530.6 472.6 551.8 562.5 567.4 575.8 7802.6 7910.7 7998.3 8044.4 8490.9 503.5 532.9 543.5 580.6 605.5 3756.3 3868.8 3876.9 3882.8 4335.5 57962.4 80435.0 103401.5 106427.0 106716.0 53323.7 82393.0 86352.6 86951.6 88248.6 78110.6 80041.0 80300.2 81603.1 83060.0 8458.9 8530.7 8533.9 8600.4 8727.2 45608.5 45673.8 45967.8 46105.3 46572.8 66463.7 69094.0 70226.0 70251.3 70795.3 11439.8 11476.5 11604.4 11604.8 12187.1 13826.8 14224.6 14316.4 14447.3 14517.2 11749.9 11856.3 12176.7 12282.2 12425.6 12713.5 12779.3 13015.2 13066.3 13347.1 12050.3 12054.5 12341.6 12913.8 12968.8 9938.5 10216.9 10251.6 10752.2 10772.1 9223.5 9612.3 9654.2 9733.0 9775.2 05:54:53 INFO - PROCESS | 3361 | -------- Summary: end -------- 05:54:53 INFO - PROCESS | 3361 | 05:54:54 INFO - TEST-INFO | 3361: exit 0 05:54:54 INFO - TEST-OK | dromaeo_css | took 1122052ms 05:54:54 INFO - TEST-START | kraken 05:54:54 INFO - operating with platform_type : linux_ 05:54:54 INFO - Initialising browser for kraken test... 05:54:54 INFO - TEST-INFO | started process 3583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbWPxTP/profile http://localhost:45002/getInfo.html) 05:54:58 INFO - PROCESS | 3583 | __metrics Screen width/height:1600/1200 05:54:58 INFO - PROCESS | 3583 | colorDepth:24 05:54:58 INFO - PROCESS | 3583 | Browser inner width/height: 1024/697 05:54:58 INFO - PROCESS | 3583 | __metrics 05:55:00 INFO - PROCESS | 3583 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:01 INFO - TEST-INFO | 3583: exit 0 05:55:01 INFO - Browser initialized. 05:55:01 INFO - Running cycle 1/1 for kraken test... 05:55:01 INFO - TEST-INFO | started process 3665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbWPxTP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:13 INFO - PROCESS | 3665 | RSS: Main: 158314496 05:55:13 INFO - PROCESS | 3665 | 05:55:15 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45002/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:16 INFO - PROCESS | 3665 | RSS: Main: 216866816 05:55:16 INFO - PROCESS | 3665 | 05:55:19 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45002/tests/kraken/driver.html?testName=audio-dft) 05:55:20 INFO - PROCESS | 3665 | RSS: Main: 203833344 05:55:20 INFO - PROCESS | 3665 | 05:55:23 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45002/tests/kraken/driver.html?testName=audio-fft) 05:55:23 INFO - PROCESS | 3665 | RSS: Main: 271417344 05:55:23 INFO - PROCESS | 3665 | 05:55:26 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45002/tests/kraken/driver.html?testName=audio-oscillator) 05:55:26 INFO - PROCESS | 3665 | RSS: Main: 181764096 05:55:26 INFO - PROCESS | 3665 | 05:55:28 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45002/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:29 INFO - PROCESS | 3665 | RSS: Main: 185544704 05:55:29 INFO - PROCESS | 3665 | 05:55:32 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45002/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:33 INFO - PROCESS | 3665 | RSS: Main: 222240768 05:55:33 INFO - PROCESS | 3665 | 05:55:36 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45002/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:37 INFO - PROCESS | 3665 | RSS: Main: 217624576 05:55:37 INFO - PROCESS | 3665 | 05:55:40 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45002/tests/kraken/driver.html?testName=json-parse-financial) 05:55:40 INFO - PROCESS | 3665 | RSS: Main: 220803072 05:55:40 INFO - PROCESS | 3665 | 05:55:42 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45002/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:43 INFO - PROCESS | 3665 | RSS: Main: 206548992 05:55:43 INFO - PROCESS | 3665 | 05:55:45 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45002/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:55:45 INFO - PROCESS | 3665 | RSS: Main: 210165760 05:55:45 INFO - PROCESS | 3665 | 05:55:47 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45002/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:55:48 INFO - PROCESS | 3665 | RSS: Main: 210739200 05:55:48 INFO - PROCESS | 3665 | 05:55:52 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45002/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:55:53 INFO - PROCESS | 3665 | RSS: Main: 223338496 05:55:53 INFO - PROCESS | 3665 | 05:55:56 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45002/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:55:56 INFO - PROCESS | 3665 | RSS: Main: 224665600 05:55:56 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:45002/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45002/tests/kraken/driver.html?testName=ai-astar) 05:55:58 INFO - PROCESS | 3665 | RSS: Main: 268722176 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | __start_tp_report 05:55:58 INFO - PROCESS | 3665 | _x_x_mozilla_page_load 05:55:58 INFO - PROCESS | 3665 | _x_x_mozilla_page_load_details 05:55:58 INFO - PROCESS | 3665 | |i|pagename|runs| 05:55:58 INFO - PROCESS | 3665 | |0;ai-astar;104;115;115;114;114;114;114;117;114;115 05:55:58 INFO - PROCESS | 3665 | |1;audio-beat-detection;144;121;125;182;124;125;150;123;154;125 05:55:58 INFO - PROCESS | 3665 | |2;audio-dft;162;162;162;162;163;163;164;161;162;160 05:55:58 INFO - PROCESS | 3665 | |3;audio-fft;76;75;78;126;76;78;74;75;109;76 05:55:58 INFO - PROCESS | 3665 | |4;audio-oscillator;85;85;115;84;83;83;117;84;84;124 05:55:58 INFO - PROCESS | 3665 | |5;imaging-gaussian-blur;117;118;117;117;116;117;117;117;117;117 05:55:58 INFO - PROCESS | 3665 | |6;imaging-darkroom;146;146;148;147;147;146;146;147;146;147 05:55:58 INFO - PROCESS | 3665 | |7;imaging-desaturate;95;96;95;95;95;96;95;95;94;95 05:55:58 INFO - PROCESS | 3665 | |8;json-parse-financial;63;64;62;63;63;63;63;63;63;62 05:55:58 INFO - PROCESS | 3665 | |9;json-stringify-tinderbox;64;65;66;65;65;65;65;65;65;65 05:55:58 INFO - PROCESS | 3665 | |10;stanford-crypto-aes;92;85;79;78;88;81;79;78;78;82 05:55:58 INFO - PROCESS | 3665 | |11;stanford-crypto-ccm;129;130;127;129;131;129;129;130;211;145 05:55:58 INFO - PROCESS | 3665 | |12;stanford-crypto-pbkdf2;174;173;174;170;173;173;169;167;173;169 05:55:58 INFO - PROCESS | 3665 | |13;stanford-crypto-sha256-iterative;67;71;74;66;70;66;66;68;66;67 05:55:58 INFO - PROCESS | 3665 | __end_tp_report 05:55:58 INFO - PROCESS | 3665 | __start_cc_report 05:55:58 INFO - PROCESS | 3665 | _x_x_mozilla_cycle_collect,1886 05:55:58 INFO - PROCESS | 3665 | __end_cc_report 05:55:58 INFO - PROCESS | 3665 | __startTimestamp1467291358748__endTimestamp 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | ------- Summary: start ------- 05:55:58 INFO - PROCESS | 3665 | Number of tests: 14 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.50 stddev:3.50 (3.1%) stddev-sans-first:1.00 05:55:58 INFO - PROCESS | 3665 | Values: 104.0 115.0 115.0 114.0 114.0 114.0 114.0 117.0 114.0 115.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:134.50 stddev:19.96 (14.8%) stddev-sans-first:21.02 05:55:58 INFO - PROCESS | 3665 | Values: 144.0 121.0 125.0 182.0 124.0 125.0 150.0 123.0 154.0 125.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 05:55:58 INFO - PROCESS | 3665 | Values: 162.0 162.0 162.0 162.0 163.0 163.0 164.0 161.0 162.0 160.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#3] audio-fft Cycles:10 Average:84.30 Median:76.00 stddev:17.99 (23.7%) stddev-sans-first:18.83 05:55:58 INFO - PROCESS | 3665 | Values: 76.0 75.0 78.0 126.0 76.0 78.0 74.0 75.0 109.0 76.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.00 stddev:16.91 (20.1%) stddev-sans-first:17.59 05:55:58 INFO - PROCESS | 3665 | Values: 85.0 85.0 115.0 84.0 83.0 83.0 117.0 84.0 84.0 124.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:55:58 INFO - PROCESS | 3665 | Values: 117.0 118.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 05:55:58 INFO - PROCESS | 3665 | Values: 146.0 146.0 148.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:55:58 INFO - PROCESS | 3665 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 05:55:58 INFO - PROCESS | 3665 | Values: 63.0 64.0 62.0 63.0 63.0 63.0 63.0 63.0 63.0 62.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 05:55:58 INFO - PROCESS | 3665 | Values: 64.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:4.85 (6.0%) stddev-sans-first:3.55 05:55:58 INFO - PROCESS | 3665 | Values: 92.0 85.0 79.0 78.0 88.0 81.0 79.0 78.0 78.0 82.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:130.00 stddev:25.80 (19.8%) stddev-sans-first:27.11 05:55:58 INFO - PROCESS | 3665 | Values: 129.0 130.0 127.0 129.0 131.0 129.0 129.0 130.0 211.0 145.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:173.00 stddev:2.51 (1.4%) stddev-sans-first:2.49 05:55:58 INFO - PROCESS | 3665 | Values: 174.0 173.0 174.0 170.0 173.0 173.0 169.0 167.0 173.0 169.0 05:55:58 INFO - PROCESS | 3665 | 05:55:58 INFO - PROCESS | 3665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:2.73 (4.0%) stddev-sans-first:2.86 05:55:58 INFO - PROCESS | 3665 | Values: 67.0 71.0 74.0 66.0 70.0 66.0 66.0 68.0 66.0 67.0 05:55:58 INFO - PROCESS | 3665 | -------- Summary: end -------- 05:55:58 INFO - PROCESS | 3665 | 05:55:59 INFO - TEST-INFO | 3665: exit 0 05:55:59 INFO - TEST-OK | kraken | took 65456ms 05:55:59 INFO - SUITE-END | took 1187s 05:55:59 INFO - Completed test suite (00:19:47) 05:55:59 INFO - javascript benchmark 05:55:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2629.8553579553127, 2631.4342416380473, 2659.614355918391, 2669.4394177222784, 2674.277944954862, 4656.5110663380365, 4711.458182309036, 4724.173269677805, 4779.16364636189, 4822.686525375848, 4689.202835517962, 4746.24060150376, 4746.359241502405, 4766.761661916899, 4778.784954677039, 4308.0952999869905, 4310.4611923509565, 4360.956390436087, 4388.912221755563, 4583.083383323332, 4463.218936686067, 4480.126375356806, 4495.640348772106, 4496.842610508633, 4514.909701805962, 4312.9137417251795, 4317.568243175658, 4347.0653809430805, 4352.455943007124, 4386.8025938832825, 4320.1575692739925, 4329.480462344539, 4332.068605249855, 4413.867583972486, 4438.045820148684, 4327.8052487637815, 4349.238883195429, 4356.978215108904, 4391.099824535962, 4398.516163222043, 4689.88275293117, 4700.529947005306, 4732.053589282123, 4771.33201351811, 4811.278308253755, 5158.92261616076, 5163.793448262065, 5177.171652535576, 5180.041692286939, 5180.326557547494, 5173.456787037345, 5196.792128314863, 5209.765560549784, 5211.24436956643, 5216.426193118754, 4683.578477937002, 4757.119932812371, 4786.0, 4793.784279707422, 4797.640176986775, 5242.842714718565, 5248.711320877388, 5297.337832770903, 5301.416844147141, 5315.920261196085, 5056.367954005749, 5059.797608095709, 5080.339555857715, 5093.312402825645, 5109.897802043938, 5000.64995450315, 5054.54509094176, 5059.038782631288, 5124.231365295235, 5124.590032797368, 5106.923396149061, 5140.794368225229, 5173.275741396207, 5182.404023537266, 5229.973850130725, 5139.229115632685, 5159.17453207485, 5160.200168973815, 5169.870753231199, 5211.557017653542, 4247.851325203603, 4284.935725964113, 4391.209582275221, 4438.489573699001, 4441.977790111094, 3847.2882516734494, 3847.9995201247875, 3856.46009558662, 3887.941680874789, 3929.0766669832565, 4437.556244375537, 4450.621697155778, 4452.354408610733, 4493.707908985905, 4496.662750293741, 4968.378952630921, 5045.84862454127, 5172.353455818023, 5221.947780522222, 5286.07493688603, 4454.309582014793, 4457.888552786207, 4476.70901391415, 4518.9832287735, 4533.750643714561, 4674.392328997209, 4686.133065382915, 4687.0, 4688.718676879398, 4735.147673418817, 4750.358701575243, 4785.0, 4824.469308376006, 4895.094407534689, 4903.8528844134735, 5179.533841954242, 5198.06434841717, 5199.29809475716, 5200.245964335075, 5242.082635538689, 4845.297431872429, 4851.1753001990455, 4859.149648811514, 4860.198067318853, 4907.092187945242, 4973.0, 5060.797568097235, 5072.9746351268, 5099.5410413063, 5128.564072053917, 5196.064708352533, 5198.766055527586, 5211.71335576547, 5221.4517475666025, 5223.7910483580235, 5034.043531728959, 5062.240663900445, 5074.11203039474, 5080.491950805038, 5116.462771408948, 4848.296996935495, 4918.852434426973, 4954.108260513142, 4971.37857767779, 5002.2496625506465, 4868.2210846264425, 4885.267209918398, 4897.608191344612, 4909.852704418873, 4936.531029552187, 4902.044101400193, 4998.575121114746, 5000.399952005782, 5009.7996080157845, 5017.774200161075, 4796.448408432935, 4840.128776820206, 4856.295837103671, 4907.067657145131, 4907.779149938333], "value": 4715.762381376252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.300636739165, 578.7540295374467, 592.2774215457141, 592.7658574862932, 592.9080992446171, 26865.731342686566, 39726.2054758905, 40815.387769183486, 40841.18317633645, 40956.38565421521, 40166.397504037464, 40323.79838100813, 40332.193356132935, 40377.0, 40409.39385909214, 7643.61781910905, 7781.0, 7921.841563168733, 7928.722494712686, 7931.087924888654, 7563.924360756377, 7804.765857024298, 7812.49218800779, 9987.0, 10292.382457052563, 10260.435676037814, 10270.486475676187, 10338.276320657556, 10349.741256468611, 10356.119729822974, 10194.796104077914, 10247.948760256226, 10256.128229100535, 10264.281500294983, 10276.537555810006, 7589.582572958485, 9964.402135871798, 10349.534270957825, 10359.27485076045, 10361.171106311476, 37144.25711485782, 37548.0, 37599.62400376016, 40584.39123413151, 40698.79650601728, 3201.247706788926, 3281.737461003114, 3297.142742886843, 3435.7594968352223, 3642.071271825694, 30548.69451305481, 32351.51472727911, 32791.50812737811, 32885.50671739926, 33065.50401743976, 3331.9666803331897, 3347.196672798535, 3368.292658541685, 3369.6630336966355, 3412.095794614429, 273112.0, 276491.3508649119, 277184.0, 277458.0, 277728.0, 58655.41344586585, 59039.704801476575, 59116.40883591195, 59153.704231478565, 59352.40647593555, 34433.0, 35304.823475882455, 35556.64443355533, 37923.0, 64090.359096408436, 14827.258637068104, 14915.552533424014, 15055.397784088733, 15058.472953446577, 15088.54734357971, 9345.112214339626, 11000.339979601249, 11003.504842282116, 11130.944345278222, 11134.888651113548, 19533.413997580094, 19774.40676779699, 19930.20279188816, 20811.271605493734, 20862.687059694115, 7355.5586664800285, 7497.700091996259, 7549.773506794805, 7611.65747541362, 7779.416543759241, 808.3533173461325, 906.4515967839494, 907.773056735816, 914.6524320758069, 985.1232403161192, 28415.289617759307, 28808.567871481944, 29266.046870823215, 29274.853625731736, 29598.852005740264, 969.3892847506168, 973.026973026973, 979.0601023017982, 983.1578635337379, 1083.4041277297456, 15240.3903843845, 15291.0, 15422.0, 15634.905556611155, 16296.83703162977, 422903.0, 424725.0, 425494.0, 427778.0, 427844.0, 49994.0, 50816.49183508191, 50892.236616450784, 50962.0, 51092.0, 1100.8238681811033, 1126.1947707389093, 1128.3963079752293, 1234.5493894728538, 1244.7883859743683, 21908.561828763653, 28983.275418114717, 29389.559156613097, 31306.379388669215, 31644.841775790974, 45745.54254457546, 46575.301370478795, 46903.76548117238, 46970.53029469798, 46990.0, 371942.0, 373915.0, 375079.0, 375461.0, 376619.0, 25627.10305139311, 25967.61048584235, 41494.0, 42497.0, 43009.3548596765, 40682.38976415297, 44269.33595995998, 44446.55553444424, 44648.0, 45236.0, 37699.29124381566, 38173.23653526858, 38257.0, 38974.0, 39374.60625393709, 38143.0, 38839.41740873833, 38842.805785970886, 39009.41485877771, 39390.80304598458, 37726.62273377231, 38490.422643660924, 38526.0, 38789.806050969564, 38812.223755525294, 32889.50665739968, 34513.0, 34543.0, 34658.51375306184, 34691.65308346985, 26270.474590508464, 26352.20943371702, 26373.60439593446, 26549.203523894314, 26960.595591065758], "value": 18704.775911139746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.84342967379496, 372.48038985615057, 372.72045965525854, 374.7152164355091, 392.9332013557695, 13169.209847409162, 16764.664706705873, 16908.323667053333, 17525.73711394327, 18337.266509339643, 15733.763993540106, 15972.920135399336, 16117.516474505783, 17305.567360815956, 17797.288108475645, 4517.503074661785, 5084.745762711868, 5281.577473802086, 5286.3392075990505, 5289.418164001957, 5129.0767661820855, 5172.715500647463, 5189.584833213334, 5193.324867767204, 5193.584513238932, 5032.345795046657, 5108.412532558747, 5177.249298851664, 5189.818356357509, 5227.817026404076, 5128.102582048145, 5134.255532947739, 5145.048166089286, 5148.562372198349, 5152.149895267314, 4621.4685311189305, 4746.620270378361, 5051.292819005343, 5057.443681195103, 5113.411957624883, 12517.937410312981, 12614.684632884251, 12677.873221267762, 12711.74576508474, 12829.807552886714, 1938.5347516596057, 1978.9505262368411, 1988.7911769264163, 1995.800419958007, 2489.265666628349, 9047.728568142966, 9209.401388909766, 9262.6294948202, 9660.516974151264, 9716.93113757486, 1675.6229848284038, 1691.2812054876752, 1693.068812153323, 1693.8644908407298, 1708.2312959168423, 69061.309386906, 75111.62444187798, 76228.61885690536, 76304.0, 77819.0, 8831.116888311117, 9502.667406640734, 9892.208623310118, 10409.219308551888, 10563.0, 12928.159669621444, 13842.515511957034, 13844.723105537832, 14329.57011289663, 14384.496542620958, 7322.597257150801, 7378.897014350884, 7411.518251313647, 7469.1037075551285, 7531.096268447822, 7209.89185162223, 7228.96385518069, 7291.270872912773, 7338.376238019721, 7438.0, 4412.536683648171, 4441.555844415532, 4476.798544065525, 4554.407926969473, 4590.472095709036, 1812.3475548802421, 1858.990705046493, 1869.7008478643625, 1877.3710806879576, 1966.7049942508452, 843.1147295339869, 868.1275318305189, 887.4630848336792, 920.8296465153834, 926.2589928057662, 17130.799179718786, 17311.826881731275, 17348.0, 18007.369742058963, 18181.272749090153, 809.7408829174608, 816.8529664660299, 863.5336918064176, 874.6807415293499, 911.1753862754218, 9680.419174849532, 9794.118529332394, 10034.996500349907, 10049.447280399649, 10174.03346682064, 394240.0, 400225.0, 400739.0, 401935.0, 403342.0, 79371.0, 83705.0, 85371.0, 85731.0, 85794.57102714447, 874.1224743791635, 881.4270724029304, 900.3652425040331, 903.0878812399524, 909.53159123053, 15568.610784730472, 15709.45016924402, 15820.28808703634, 15946.202689865693, 16238.188090595659, 38160.80919595496, 39271.0, 39420.81737547878, 40350.798246008584, 40362.0, 54060.0, 54596.72701636466, 55666.0, 55730.72134639301, 56074.0, 7593.658285377061, 7759.4568380215105, 7791.649375778217, 7863.174366691415, 7936.523808571505, 8505.532195729294, 10858.402787846428, 11594.47824847867, 11736.770013697711, 11980.880191198325, 9973.50132493387, 10228.846567301645, 10283.84574231402, 10462.738431538968, 10575.101116405192, 9829.655962041294, 10314.071733544017, 10509.842352364567, 10556.84164737545, 10677.9466102669, 9659.758506037406, 9661.13049825519, 9728.0, 10045.246606504688, 10158.339707918962, 7694.461387702807, 7736.303732664087, 7753.689852405841, 7888.566128862968, 7964.442489025712, 9093.0, 9388.295877809054, 9757.853632195382, 9801.0, 9982.900170998197], "value": 8153.018582540471, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.8774122587747, 1390.8539603341649, 1441.4450436581917, 1517.946871859485, 1734.340950438833, 7353.1911489736085, 7671.69313227471, 7696.345810606092, 7895.486793358442, 7901.604919754018, 7661.731839385623, 7802.531848089118, 7805.297523222909, 7809.492382995116, 7823.374130069595, 2206.1396055538353, 2235.5305385868987, 2236.944076398087, 2243.921462748804, 2246.696695946051, 2106.820920221783, 2108.873467591942, 2115.0, 2145.839062070343, 2219.83351248657, 2157.3635777445693, 2169.457635591102, 2183.094015983365, 2198.087793565668, 2201.5046614511766, 2141.0, 2156.0836644426136, 2156.471664442206, 2159.6220661384273, 2162.664786958024, 2096.9056392462376, 2121.6499277619173, 2125.8724476531456, 2132.477543001959, 2138.5615948730474, 7711.498752581064, 7728.536287822749, 7745.496542724762, 7794.142644309121, 8033.598320084031, 4461.57615026572, 4552.430946131733, 4559.703619264737, 4561.543845615445, 4577.56513131252, 2865.28367908023, 2940.794144409892, 3014.216303761038, 3014.608100946863, 3019.0791808498398, 987.6938149173707, 994.3636072913341, 1004.5328922051208, 1009.2027298434228, 1016.7153197104823, 10854.511546980404, 10953.123750099972, 10972.122230221563, 10979.396133212671, 10990.505427255714, 4042.8584999525465, 4256.404103425523, 4402.0755641315045, 4415.205263052617, 4473.776311184492, 8823.294136469067, 8915.955420222857, 8921.910780892107, 8931.106889311146, 8936.776580585407, 4590.747508886977, 4604.171249175113, 4610.170169369479, 4615.123126605934, 4616.6537509686905, 3472.2361080562237, 3626.2022355082368, 4108.609682080198, 4276.786160691953, 4277.0, 3401.064707205489, 3418.1967237699123, 3427.9828600857336, 3450.4996775467916, 3480.686738193524, 1014.2342531388902, 1036.6475398364441, 1043.3739756146251, 1045.1899777672213, 1051.2641151194196, 829.1459796409587, 840.4705035827512, 845.8984921809299, 863.7538301584018, 886.2821114896955, 5103.157978933435, 5243.397009343974, 5260.500252476085, 5334.333208348957, 5388.164834450667, 417.18232264761406, 419.6747520671504, 425.48728781817834, 425.63608115061174, 430.01741021765116, 3523.753337266418, 3715.777053376806, 3716.2753263113973, 3723.925521489555, 3738.12154143776, 9639.662611808553, 10183.898161018444, 10186.847197292047, 10193.286469947032, 10197.592096316213, 9973.80052398948, 10042.497875106215, 10053.095221430107, 10064.44645544502, 10071.093601575747, 7076.044733960953, 7145.92854071463, 7149.356557909813, 7152.070230869954, 7153.785386438415, 5049.798008079636, 5083.186690129562, 5106.872328191825, 5178.741062946913, 5197.038547868657, 9287.34988550822, 9290.72127836166, 9316.161545460942, 9334.0, 9370.062993700576, 9175.036621154683, 9708.951455242679, 9717.12545870875, 9723.56243969009, 9737.0, 5802.564807639359, 5961.880762384815, 5978.103284507185, 6119.0, 6122.602030867979, 7464.253574642492, 7727.150013498623, 7735.110462296908, 7919.564423956737, 7930.762077137695, 6959.547629404275, 7034.261402552658, 7126.643667816485, 7179.497435179696, 7187.892181617175, 6806.55757375769, 6875.346842049998, 6893.414059804973, 6988.091548098715, 7008.789736307919, 5983.521318294613, 6101.176341193882, 6104.023356262976, 6105.603135796159, 6111.877762444815, 4481.7535035573355, 4509.0080182359825, 4539.137563862855, 4567.132244873596, 4609.032103258353, 4511.300748384006, 4541.341505481752, 4627.745473998963, 4660.184467718203, 4708.434987801349], "value": 4061.546659471059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.3620093067653, 293.3121829310267, 298.1071690287589, 304.5857633618279, 306.78218464889926, 4800.447948485921, 4865.513448655132, 4872.293517439969, 4879.414470263565, 4890.413150421954, 4800.49594792547, 4801.567858892699, 4806.086843499741, 4809.759512024402, 4815.446223684277, 3588.1926566522584, 3646.3618866698353, 3704.6663201247666, 3765.058735316171, 3810.0, 3763.5860055393887, 3777.5655799582987, 3779.2063666630042, 3787.9431808522895, 3795.2978698940647, 3564.910877228077, 3745.9250814983684, 3747.4704574412162, 3748.306563285801, 3748.887533374003, 3636.436352365374, 3757.8121093945465, 3764.171882185915, 3765.755225910321, 3773.64150405711, 3315.61870384904, 3326.750493712957, 3335.7498187636024, 3338.8314090068525, 3345.6821601947777, 4660.834791302174, 4676.602488788457, 4685.133250348662, 4698.238160689742, 4699.673661537527, 4169.749815011109, 4265.893352666177, 4281.914361712779, 4358.782060896974, 4359.520452750195, 5047.671901326402, 5059.2916991621205, 5059.772310246048, 5061.582756828094, 5062.0, 3688.0964163780045, 3690.132818787583, 3691.7600355977042, 3696.8336424860945, 3697.5949139326885, 4990.975045124787, 5266.368035835724, 5281.551068159211, 5287.629865909388, 5291.656042357235, 3614.6385361463645, 3630.237650093457, 3630.673239408466, 3635.5092062571744, 3643.5425829668343, 3679.5768486623847, 3683.594804571495, 3684.889453316405, 3685.244524872395, 3698.7992144673876, 4218.282891908321, 4222.451081359403, 4228.133232687292, 4245.80893859777, 4250.192463431938, 4819.156647586658, 5094.77073531692, 5103.234514822732, 5103.744812759422, 5104.366602687104, 1270.0411189551828, 1276.6361586947676, 1279.309173046563, 1281.7756892543769, 1282.2819221235952, 815.2540425510709, 815.6166601697192, 842.5045544159044, 853.6542700206427, 860.9827803443897, 4402.163588918095, 4409.250427427345, 4414.205443020287, 4449.466064072332, 4460.643148548108, 5174.741262936914, 5176.663516871391, 5185.433210560796, 5188.143956247252, 5190.506901844319, 4260.936085958713, 4426.291793313055, 4446.9777651111535, 4446.9777651111535, 4459.130469558405, 2746.491898998652, 2750.8349499030123, 2762.7513523782955, 2763.2677340504783, 2770.5428604280473, 4804.375431193923, 4811.326414302001, 4812.855614331575, 4821.445533763592, 4826.262545483623, 5092.911906118474, 5154.9484505155215, 5230.320058392384, 5244.187150991603, 5281.709505977131, 4811.735354555463, 4821.841693690638, 4854.927176092361, 4861.611071114302, 4866.6350023747655, 5126.384833819965, 5134.178531434953, 5138.280640710378, 5141.7686204120155, 5166.354205724285, 4852.466228714768, 5071.87320316995, 5073.771680274471, 5076.883085721135, 5081.923771143362, 4818.0, 4837.234409440599, 4839.491853355347, 4848.763565290828, 4861.927071093865, 3633.563972323338, 3637.2907283079544, 3646.489491471249, 3648.142686468731, 3652.4886515887265, 4869.342638743866, 5074.771635276347, 5152.27868098474, 5158.845234642967, 5191.974040129775, 5078.187490001582, 5084.720340381315, 5085.389753229636, 5101.132807422821, 5114.488551144856, 5091.974540127424, 5099.0, 5102.974485127699, 5106.438291787975, 5107.463716309734, 4790.568848803624, 4982.978489409735, 4985.6011519077665, 4992.600591952562, 4996.550310472075, 4855.635827312895, 4980.5019498049905, 5095.87260318495, 5122.206058061007, 5125.461826508163, 4977.228529577921, 4990.700557966534, 4998.6500944933505, 5003.199488081889, 5011.473795251446], "value": 3791.810988543215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.6365471681142, 669.8224970382853, 677.3971165662564, 685.6160550091948, 706.0100474490532, 12361.876381236185, 12697.619071427873, 12711.919486843617, 12716.427760750777, 12725.30010849403, 12444.937775311133, 12698.238105713664, 12702.110852240347, 12713.427895744691, 12761.936190319058, 632.7975047984647, 774.5701135869605, 783.561205724796, 788.4008153803094, 791.3550456378063, 797.5972134072285, 814.3322475570035, 814.4868732698392, 816.6692489541745, 816.9918300816976, 858.3004851046409, 861.9525926074064, 862.8835107260534, 863.0549548244662, 863.7322430046675, 666.6233578028398, 812.4678335690132, 843.3000609494105, 856.1780690537092, 856.6787454704486, 622.0700053420165, 622.8007037747923, 623.0436280309702, 623.7349126621168, 623.840920565253, 13098.672533186651, 13107.672308192372, 13121.0, 13130.343482825916, 13145.474181032747, 11744.647660570197, 11882.702932426671, 12276.32480213588, 12425.875741242562, 12619.43212555428, 9882.9505852471, 9905.405675659484, 10064.345817521911, 10350.068493835515, 11011.394373309466, 4273.9358909616385, 4314.3528470729325, 4358.5205627380965, 4448.243798554221, 4449.310356894686, 62160.68919655418, 62612.0, 63345.36654633441, 63943.0, 63959.0, 10565.39006526035, 10715.624953126604, 10727.249092563447, 10759.677209683721, 11125.332480051224, 18641.81358186428, 18651.533711657317, 18665.0, 18692.252309907723, 18943.43169704911, 6681.866362672719, 6719.395254427125, 6793.184817821893, 6849.212340580797, 6893.827654308682, 3646.3072016316814, 3652.5251717277115, 3661.7253705972157, 3739.7569158004644, 3747.5690295616355, 2851.087651951356, 2928.2093834664947, 2938.30949726814, 2940.529515277588, 2942.3526824098662, 511.3046257090354, 514.765781569385, 515.6828550441527, 516.6693316277585, 530.6391653675538, 472.6195412692815, 551.7778121460983, 562.4965655738173, 567.3532173322416, 575.7639367859241, 7802.570858602718, 7910.683572657029, 7998.320142787812, 8044.4368894178015, 8490.872636910452, 503.5468078729173, 532.9360476742816, 543.5407081016534, 580.5587753307517, 605.5428151745404, 3756.323861704919, 3868.845246190121, 3876.9224615507533, 3882.825272862728, 4335.479742430928, 57962.4203757957, 80435.0, 103401.48299258456, 106427.0, 106716.0, 53323.733381332844, 82393.0, 86352.56823715841, 86951.56524217338, 88248.5587572071, 78110.60944695353, 80041.0, 80300.19699803044, 81603.10381377136, 83060.0, 8458.915410845813, 8530.658773648984, 8533.914660853561, 8600.354973377147, 8727.214550690469, 45608.54391456043, 45673.77163114163, 45967.77016114898, 46105.30842037305, 46572.76713616546, 66463.66768166129, 69094.0, 70226.0, 70251.29748702448, 70795.29204708093, 11439.828402573801, 11476.483558240066, 11604.375387445933, 11604.767904642029, 12187.085968552217, 13826.82188799628, 14224.573262802132, 14316.355763990437, 14447.349869256119, 14517.201553914636, 11749.88250117488, 11856.34790086519, 12176.695582610506, 12282.219078233427, 12425.62723118308, 12713.491460341484, 12779.349714569373, 13015.219086854819, 13066.281354525212, 13347.132436391603, 12050.337231452355, 12054.457549410123, 12341.568045118378, 12913.806292905801, 12968.805467918177, 9938.45338506389, 10216.948915255674, 10251.641192558225, 10752.193585480964, 10772.138228941509, 9223.538823058687, 9612.279079069238, 9654.179394751525, 9733.0, 9775.217982561237], "value": 6682.165379933784, "unit": "score"}], "name": "dromaeo_css", "value": 6479.704192926929, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 117.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 125.0, 182.0, 124.0, 125.0, 150.0, 123.0, 154.0, 125.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 164.0, 161.0, 162.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 126.0, 76.0, 78.0, 74.0, 75.0, 109.0, 76.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 84.0, 83.0, 83.0, 117.0, 84.0, 84.0, 124.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 85.0, 79.0, 78.0, 88.0, 81.0, 79.0, 78.0, 78.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 127.0, 129.0, 131.0, 129.0, 129.0, 130.0, 211.0, 145.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 174.0, 170.0, 173.0, 173.0, 169.0, 167.0, 173.0, 169.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 74.0, 66.0, 70.0, 66.0, 66.0, 68.0, 66.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1538.9, "alertThreshold": 2.0}]} 05:56:00 INFO - Return code: 0 05:56:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:56:00 INFO - # TBPL SUCCESS # 05:56:00 INFO - Running post-action listener: _resource_record_post_action 05:56:00 INFO - ##### 05:56:00 INFO - ##### Finished run-tests step (success) 05:56:00 INFO - ##### 05:56:00 INFO - Running post-run listener: _resource_record_post_run 05:56:00 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 30302208; Write bytes: 431857664; Read time: 2980; Write time: 418100 05:56:00 INFO - TinderboxPrint: CPU usage
13.0% 05:56:00 INFO - TinderboxPrint: I/O read bytes / time
30,302,208 / 2,980 05:56:00 INFO - TinderboxPrint: I/O write bytes / time
431,857,664 / 418,100 05:56:00 INFO - TinderboxPrint: CPU idle
8,363.0 (87.0%) 05:56:00 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 05:56:00 INFO - TinderboxPrint: Swap in / out
0 / 0 05:56:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 96043008; Read time: 0; Write time: 99368 05:56:00 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 28086272; Write bytes: 335814656; Read time: 2812; Write time: 318732 05:56:00 INFO - Running post-run listener: _upload_blobber_files 05:56:00 INFO - Blob upload gear active. 05:56:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:56:00 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 05:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:56:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:56:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:56:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:02 INFO - (blobuploader) - INFO - Done attempting. 05:56:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:56:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:56:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:03 INFO - (blobuploader) - INFO - Done attempting. 05:56:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:56:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:56:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:09 INFO - (blobuploader) - INFO - Done attempting. 05:56:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:09 INFO - Return code: 0 05:56:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:56:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00e097a9e246d02a524a444fa45723180c20ad7600afca57ad7fa27228ee09255da0e1be9288c2b8c422e01bad42113f94f2248edcc3c69be4bb4b1ff7141476", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6be51c1c9346e27974bbf5d56cf4c21a6a717156ef8e958d779f7e2b6270b5cd0680e20bad091adf2d3bab6c863de3a5392e4993d911759e1e289ec7eca64f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cfa971b14de059ddcf330ccaab059b5f2cfb8047902f8a25371e0663bea1ad5d99e0282f4bf326804eadf1076a228ff66e8b63ab5824c2685a26f778e2ea29ad"} 05:56:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:56:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:56:09 INFO - Contents: 05:56:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00e097a9e246d02a524a444fa45723180c20ad7600afca57ad7fa27228ee09255da0e1be9288c2b8c422e01bad42113f94f2248edcc3c69be4bb4b1ff7141476", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6be51c1c9346e27974bbf5d56cf4c21a6a717156ef8e958d779f7e2b6270b5cd0680e20bad091adf2d3bab6c863de3a5392e4993d911759e1e289ec7eca64f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cfa971b14de059ddcf330ccaab059b5f2cfb8047902f8a25371e0663bea1ad5d99e0282f4bf326804eadf1076a228ff66e8b63ab5824c2685a26f778e2ea29ad"} 05:56:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:09 INFO - Copying logs to upload dir... 05:56:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:56:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.879042 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-30 05:56:09.696213) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 05:56:09.699589) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00e097a9e246d02a524a444fa45723180c20ad7600afca57ad7fa27228ee09255da0e1be9288c2b8c422e01bad42113f94f2248edcc3c69be4bb4b1ff7141476", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6be51c1c9346e27974bbf5d56cf4c21a6a717156ef8e958d779f7e2b6270b5cd0680e20bad091adf2d3bab6c863de3a5392e4993d911759e1e289ec7eca64f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cfa971b14de059ddcf330ccaab059b5f2cfb8047902f8a25371e0663bea1ad5d99e0282f4bf326804eadf1076a228ff66e8b63ab5824c2685a26f778e2ea29ad"} build_url:https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011093 build_url: 'https://queue.taskcluster.net/v1/task/V9qdPVPeQCmjKCchE5ZNhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00e097a9e246d02a524a444fa45723180c20ad7600afca57ad7fa27228ee09255da0e1be9288c2b8c422e01bad42113f94f2248edcc3c69be4bb4b1ff7141476", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6be51c1c9346e27974bbf5d56cf4c21a6a717156ef8e958d779f7e2b6270b5cd0680e20bad091adf2d3bab6c863de3a5392e4993d911759e1e289ec7eca64f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cfa971b14de059ddcf330ccaab059b5f2cfb8047902f8a25371e0663bea1ad5d99e0282f4bf326804eadf1076a228ff66e8b63ab5824c2685a26f778e2ea29ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 05:56:09.725203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:56:09.725521) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467290113.546243-2082392304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:56:09.810941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 05:56:09.811262) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 05:56:09.811546) ========= ========= Total master_lag: 0.22 =========