builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1467649093.41 results: success (0) buildid: 20160704085124 builduid: 7b72c404321348da98ffe837fb77673e revision: 7eef107d8d310cc5c0419d3fd3bf7f74590da3db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:13.415379) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:13.415907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:13.416228) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:13.432182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:13.432535) ========= 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=523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 09:18:13-- 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% 213M=0s 2016-07-04 09:18:13 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115726 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:13.563321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:13.563684) ========= 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=523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014961 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:13.613461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:13.613864) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7eef107d8d310cc5c0419d3fd3bf7f74590da3db --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 7eef107d8d310cc5c0419d3fd3bf7f74590da3db --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=523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 09:18:13,707 truncating revision to first 12 chars 2016-07-04 09:18:13,707 Setting DEBUG logging. 2016-07-04 09:18:13,707 attempt 1/10 2016-07-04 09:18:13,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7eef107d8d31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 09:18:14,309 unpacking tar archive at: fx-team-7eef107d8d31/testing/mozharness/ program finished with exit code 0 elapsedTime=0.952066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:14.579961) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:14.580311) ========= script_repo_revision: 7eef107d8d310cc5c0419d3fd3bf7f74590da3db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:14.580721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:14.580989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 09:18:14.591902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-04 09:18:14.592316) ========= /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=523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:18:14 INFO - MultiFileLogger online at 20160704 09:18:14 in /builds/slave/test 09:18:14 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 09:18:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:14 INFO - {'append_to_log': False, 09:18:14 INFO - 'base_work_dir': '/builds/slave/test', 09:18:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:18:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:14 INFO - 'branch': 'Fx-Team-Non-PGO', 09:18:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:14 INFO - 'config_files': ('talos/linux_config.py',), 09:18:14 INFO - 'default_actions': ('clobber', 09:18:14 INFO - 'read-buildbot-config', 09:18:14 INFO - 'download-and-extract', 09:18:14 INFO - 'populate-webroot', 09:18:14 INFO - 'create-virtualenv', 09:18:14 INFO - 'install', 09:18:14 INFO - 'run-tests'), 09:18:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:14 INFO - 'download_minidump_stackwalk': True, 09:18:14 INFO - 'download_symbols': 'ondemand', 09:18:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:14 INFO - 'installer_path': 'installer.exe', 09:18:14 INFO - 'log_level': 'info', 09:18:14 INFO - 'log_name': 'talos', 09:18:14 INFO - 'log_to_console': True, 09:18:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:18:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:18:14 INFO - 'opt_config_files': (), 09:18:14 INFO - 'pip_index': False, 09:18:14 INFO - 'sps_profile': False, 09:18:14 INFO - 'sps_profile_interval': 0, 09:18:14 INFO - 'suite': 'dromaeojs', 09:18:14 INFO - 'system_bits': '32', 09:18:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:14 INFO - 'title': 'talos-linux64-ix-065', 09:18:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:14 INFO - 'use_talos_json': True, 09:18:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:14 INFO - 'work_dir': 'build'} 09:18:14 INFO - ##### 09:18:14 INFO - ##### Running clobber step. 09:18:14 INFO - ##### 09:18:14 INFO - Running pre-action listener: _resource_record_pre_action 09:18:14 INFO - Running main action method: clobber 09:18:14 INFO - rmtree: /builds/slave/test/build 09:18:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:15 INFO - Running post-action listener: _resource_record_post_action 09:18:15 INFO - ##### 09:18:15 INFO - ##### Finished clobber step (success) 09:18:15 INFO - ##### 09:18:15 INFO - ##### 09:18:15 INFO - ##### Running read-buildbot-config step. 09:18:15 INFO - ##### 09:18:15 INFO - Running pre-action listener: _resource_record_pre_action 09:18:15 INFO - Running main action method: read_buildbot_config 09:18:15 INFO - Using buildbot properties: 09:18:15 INFO - { 09:18:15 INFO - "project": "", 09:18:15 INFO - "product": "firefox", 09:18:15 INFO - "script_repo_revision": "production", 09:18:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:18:15 INFO - "repository": "", 09:18:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:18:15 INFO - "buildid": "20160704085124", 09:18:15 INFO - "pgo_build": "False", 09:18:15 INFO - "basedir": "/builds/slave/test", 09:18:15 INFO - "buildnumber": 1790, 09:18:15 INFO - "slavename": "talos-linux64-ix-065", 09:18:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:18:15 INFO - "platform": "ubuntu64_hw", 09:18:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:18:15 INFO - "branch": "fx-team", 09:18:15 INFO - "repo_path": "integration/fx-team", 09:18:15 INFO - "revision": "7eef107d8d310cc5c0419d3fd3bf7f74590da3db", 09:18:15 INFO - "stage_platform": "linux64", 09:18:15 INFO - "builduid": "7b72c404321348da98ffe837fb77673e", 09:18:15 INFO - "slavebuilddir": "test" 09:18:15 INFO - } 09:18:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:18:15 INFO - Running post-action listener: _resource_record_post_action 09:18:15 INFO - ##### 09:18:15 INFO - ##### Finished read-buildbot-config step (success) 09:18:15 INFO - ##### 09:18:15 INFO - ##### 09:18:15 INFO - ##### Running download-and-extract step. 09:18:15 INFO - ##### 09:18:15 INFO - Running pre-action listener: _resource_record_pre_action 09:18:15 INFO - Running main action method: download_and_extract 09:18:15 INFO - mkdir: /builds/slave/test/build/tests 09:18:15 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')]} 09:18:15 INFO - https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:18:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:18:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:18:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:18:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:18:16 INFO - Downloaded 1361 bytes. 09:18:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:18:16 INFO - Using the following test package requirements: 09:18:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:18:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:18:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:18:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:16 INFO - u'jsshell-linux-x86_64.zip'], 09:18:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:18:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:18:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:18:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:18:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:18:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:18:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:16 INFO - https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:18:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:18:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:18:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:18:17 INFO - Downloaded 22710212 bytes. 09:18:17 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'] 09:18:17 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 09:18:18 INFO - Return code: 0 09:18:18 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 09:18: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')]} 09:18:18 INFO - https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:18:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:18:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:18:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:18:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:18:19 INFO - Downloaded 22710212 bytes. 09:18:19 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'] 09:18:19 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 09:18:21 INFO - Return code: 0 09:18: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')]} 09:18:21 INFO - https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:18:22 INFO - Downloaded 14403333 bytes. 09:18:22 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'] 09:18:22 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 09:18:22 INFO - Return code: 0 09:18:22 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')]} 09:18:22 INFO - https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:18:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:18:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:18:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:18:23 INFO - Downloaded 56486765 bytes. 09:18:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:18:23 INFO - mkdir: /builds/slave/test/properties 09:18:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:18:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:18:23 INFO - Contents: 09:18:23 INFO - build_url:https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:18:24 INFO - Running post-action listener: _resource_record_post_action 09:18:24 INFO - Running post-action listener: set_extra_try_arguments 09:18:24 INFO - ##### 09:18:24 INFO - ##### Finished download-and-extract step (success) 09:18:24 INFO - ##### 09:18:24 INFO - ##### 09:18:24 INFO - ##### Running populate-webroot step. 09:18:24 INFO - ##### 09:18:24 INFO - Running pre-action listener: _resource_record_pre_action 09:18:24 INFO - Running main action method: populate_webroot 09:18:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:18:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:18:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:18:24 INFO - '--tppagecycles', 09:18:24 INFO - '7'], 09:18:24 INFO - 'tests': ['tsvgm']}}, 09:18:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:18:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:18:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:18:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:18:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:24 INFO - 'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:24 INFO - 'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['damp', 'tps']}, 09:18:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:24 INFO - 'tests': ['damp', 'tps']}, 09:18:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['dromaeo_dom']}, 09:18:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:18:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['basic_compositor_video']}, 09:18:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:18:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['a11yr', 09:18:24 INFO - 'ts_paint', 09:18:24 INFO - 'tpaint', 09:18:24 INFO - 'sessionrestore', 09:18:24 INFO - 'sessionrestore_no_auto_restore', 09:18:24 INFO - 'tabpaint']}, 09:18:24 INFO - 'other-e10s': {'tests': ['a11yr', 09:18:24 INFO - 'ts_paint', 09:18:24 INFO - 'tpaint', 09:18:24 INFO - 'sessionrestore', 09:18:24 INFO - 'sessionrestore_no_auto_restore', 09:18:24 INFO - 'tabpaint']}, 09:18:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:18:24 INFO - 'ts_paint', 09:18:24 INFO - 'tpaint', 09:18:24 INFO - 'sessionrestore', 09:18:24 INFO - 'sessionrestore_no_auto_restore', 09:18:24 INFO - 'tabpaint']}, 09:18:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:18:24 INFO - 'ts_paint', 09:18:24 INFO - 'tpaint', 09:18:24 INFO - 'sessionrestore', 09:18:24 INFO - 'sessionrestore_no_auto_restore', 09:18:24 INFO - 'tabpaint']}, 09:18:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['a11yr', 09:18:24 INFO - 'ts_paint', 09:18:24 INFO - 'tpaint', 09:18:24 INFO - 'sessionrestore', 09:18:24 INFO - 'sessionrestore_no_auto_restore', 09:18:24 INFO - 'tabpaint']}, 09:18:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['a11yr', 09:18:24 INFO - 'ts_paint', 09:18:24 INFO - 'tpaint', 09:18:24 INFO - 'sessionrestore', 09:18:24 INFO - 'sessionrestore_no_auto_restore', 09:18:24 INFO - 'tabpaint']}, 09:18:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['tsvgx', 09:18:24 INFO - 'tsvgr_opacity', 09:18:24 INFO - 'tart', 09:18:24 INFO - 'tscrollx', 09:18:24 INFO - 'cart']}, 09:18:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:18:24 INFO - 'tsvgr_opacity', 09:18:24 INFO - 'tart', 09:18:24 INFO - 'tscrollx', 09:18:24 INFO - 'cart']}, 09:18:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:24 INFO - 'talos_options': ['--disable-e10s'], 09:18:24 INFO - 'tests': ['tp5o']}, 09:18:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:24 INFO - 'tests': ['tp5o']}, 09:18:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:24 INFO - 'talos_options': ['--disable-e10s', 09:18:24 INFO - '--xperf_path', 09:18:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:24 INFO - 'tests': ['tp5n']}, 09:18:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:24 INFO - 'talos_options': ['--xperf_path', 09:18:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:24 INFO - 'tests': ['tp5n']}}, 09:18:24 INFO - 'talos.zip': {'path': '', 09:18:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:18:24 INFO - Running post-action listener: _resource_record_post_action 09:18:24 INFO - ##### 09:18:24 INFO - ##### Finished populate-webroot step (success) 09:18:24 INFO - ##### 09:18:24 INFO - ##### 09:18:24 INFO - ##### Running create-virtualenv step. 09:18:24 INFO - ##### 09:18:24 INFO - Running pre-action listener: _resource_record_pre_action 09:18:24 INFO - Running main action method: create_virtualenv 09:18:24 INFO - Creating virtualenv /builds/slave/test/build/venv 09:18:24 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 09:18:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:18:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:18:24 INFO - Using real prefix '/usr' 09:18:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:18:25 INFO - Installing distribute.............................................................................................................................................................................................done. 09:18:27 INFO - Installing pip.................done. 09:18:27 INFO - Return code: 0 09:18:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:18:27 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')]} 09:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:27 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')]} 09:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:27 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d3b0>, '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 0x2d5e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e740>, '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': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', '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 09:18:27 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 09:18:27 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 09:18:27 INFO - Using env: {'DISPLAY': ':0', 09:18:27 INFO - 'HOME': '/home/cltbld', 09:18:27 INFO - 'LANG': 'en_US.UTF-8', 09:18:27 INFO - 'LANGUAGE': 'en_US:en', 09:18:27 INFO - 'LOGNAME': 'cltbld', 09:18:27 INFO - 'MAIL': '/var/mail/cltbld', 09:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:27 INFO - 'MOZ_NO_REMOTE': '1', 09:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:27 INFO - 'NO_EM_RESTART': '1', 09:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:27 INFO - 'PWD': '/builds/slave/test', 09:18:27 INFO - 'SHELL': '/bin/bash', 09:18:27 INFO - 'SHLVL': '1', 09:18:27 INFO - 'TERM': 'linux', 09:18:27 INFO - 'TMOUT': '86400', 09:18:27 INFO - 'USER': 'cltbld', 09:18:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', 09:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:27 INFO - '_': '/tools/buildbot/bin/python'} 09:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:27 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 09:18:27 INFO - Cleaning up... 09:18:27 INFO - Return code: 0 09:18:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:18:27 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')]} 09:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:27 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')]} 09:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:27 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d3b0>, '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 0x2d5e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e740>, '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': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', '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 09:18:27 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 09:18:27 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 09:18:27 INFO - Using env: {'DISPLAY': ':0', 09:18:27 INFO - 'HOME': '/home/cltbld', 09:18:27 INFO - 'LANG': 'en_US.UTF-8', 09:18:27 INFO - 'LANGUAGE': 'en_US:en', 09:18:27 INFO - 'LOGNAME': 'cltbld', 09:18:27 INFO - 'MAIL': '/var/mail/cltbld', 09:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:27 INFO - 'MOZ_NO_REMOTE': '1', 09:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:27 INFO - 'NO_EM_RESTART': '1', 09:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:27 INFO - 'PWD': '/builds/slave/test', 09:18:27 INFO - 'SHELL': '/bin/bash', 09:18:27 INFO - 'SHLVL': '1', 09:18:27 INFO - 'TERM': 'linux', 09:18:27 INFO - 'TMOUT': '86400', 09:18:27 INFO - 'USER': 'cltbld', 09:18:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', 09:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:27 INFO - '_': '/tools/buildbot/bin/python'} 09:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:27 INFO - Downloading/unpacking psutil>=3.1.1 09:18:27 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 09:18:27 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 09:18:27 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 09:18:27 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 09:18:27 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 09:18:27 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 09:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:18:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:29 INFO - Installing collected packages: psutil 09:18:29 INFO - Running setup.py install for psutil 09:18:29 INFO - building 'psutil._psutil_linux' extension 09:18:29 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 09:18:29 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 09:18:29 INFO - building 'psutil._psutil_posix' extension 09:18:29 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 09:18:29 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 09:18:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:29 INFO - Successfully installed psutil 09:18:29 INFO - Cleaning up... 09:18:30 INFO - Return code: 0 09:18:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d3b0>, '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 0x2d5e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e740>, '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': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', '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 09:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:18:30 INFO - Using env: {'DISPLAY': ':0', 09:18:30 INFO - 'HOME': '/home/cltbld', 09:18:30 INFO - 'LANG': 'en_US.UTF-8', 09:18:30 INFO - 'LANGUAGE': 'en_US:en', 09:18:30 INFO - 'LOGNAME': 'cltbld', 09:18:30 INFO - 'MAIL': '/var/mail/cltbld', 09:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:30 INFO - 'MOZ_NO_REMOTE': '1', 09:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:30 INFO - 'NO_EM_RESTART': '1', 09:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:30 INFO - 'PWD': '/builds/slave/test', 09:18:30 INFO - 'SHELL': '/bin/bash', 09:18:30 INFO - 'SHLVL': '1', 09:18:30 INFO - 'TERM': 'linux', 09:18:30 INFO - 'TMOUT': '86400', 09:18:30 INFO - 'USER': 'cltbld', 09:18:30 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', 09:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:30 INFO - '_': '/tools/buildbot/bin/python'} 09:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:32 INFO - Installing collected packages: mozsystemmonitor 09:18:32 INFO - Running setup.py install for mozsystemmonitor 09:18:32 INFO - Successfully installed mozsystemmonitor 09:18:32 INFO - Cleaning up... 09:18:32 INFO - Return code: 0 09:18:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18:32 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')]} 09:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:32 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')]} 09:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:32 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d3b0>, '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 0x2d5e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e740>, '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': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', '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 09:18:32 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 09:18:32 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 09:18:32 INFO - Using env: {'DISPLAY': ':0', 09:18:32 INFO - 'HOME': '/home/cltbld', 09:18:32 INFO - 'LANG': 'en_US.UTF-8', 09:18:32 INFO - 'LANGUAGE': 'en_US:en', 09:18:32 INFO - 'LOGNAME': 'cltbld', 09:18:32 INFO - 'MAIL': '/var/mail/cltbld', 09:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:32 INFO - 'MOZ_NO_REMOTE': '1', 09:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:32 INFO - 'NO_EM_RESTART': '1', 09:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:32 INFO - 'PWD': '/builds/slave/test', 09:18:32 INFO - 'SHELL': '/bin/bash', 09:18:32 INFO - 'SHLVL': '1', 09:18:32 INFO - 'TERM': 'linux', 09:18:32 INFO - 'TMOUT': '86400', 09:18:32 INFO - 'USER': 'cltbld', 09:18:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', 09:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:32 INFO - '_': '/tools/buildbot/bin/python'} 09:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:32 INFO - Downloading/unpacking jsonschema==2.5.1 09:18:32 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 09:18:32 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 09:18:32 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 09:18:32 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 09:18:32 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 09:18:32 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 09:18:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:34 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 09:18:34 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 09:18:34 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 09:18:34 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 09:18:34 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 09:18:34 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 09:18:34 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:34 INFO - warning: no files found matching '*.txt' 09:18:34 INFO - no previously-included directories found matching 'build' 09:18:34 INFO - no previously-included directories found matching 'dist' 09:18:34 INFO - no previously-included directories found matching '.git*' 09:18:34 INFO - Installing collected packages: jsonschema, functools32 09:18:34 INFO - Running setup.py install for functools32 09:18:34 INFO - warning: no files found matching '*.txt' 09:18:34 INFO - no previously-included directories found matching 'build' 09:18:34 INFO - no previously-included directories found matching 'dist' 09:18:34 INFO - no previously-included directories found matching '.git*' 09:18:34 INFO - Successfully installed jsonschema functools32 09:18:34 INFO - Cleaning up... 09:18:34 INFO - Return code: 0 09:18:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:34 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d3b0>, '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 0x2d5e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e740>, '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': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', '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 09:18:34 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 09:18:34 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 09:18:34 INFO - Using env: {'DISPLAY': ':0', 09:18:34 INFO - 'HOME': '/home/cltbld', 09:18:34 INFO - 'LANG': 'en_US.UTF-8', 09:18:34 INFO - 'LANGUAGE': 'en_US:en', 09:18:34 INFO - 'LOGNAME': 'cltbld', 09:18:34 INFO - 'MAIL': '/var/mail/cltbld', 09:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:34 INFO - 'MOZ_NO_REMOTE': '1', 09:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:34 INFO - 'NO_EM_RESTART': '1', 09:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:34 INFO - 'PWD': '/builds/slave/test', 09:18:34 INFO - 'SHELL': '/bin/bash', 09:18:34 INFO - 'SHLVL': '1', 09:18:34 INFO - 'TERM': 'linux', 09:18:34 INFO - 'TMOUT': '86400', 09:18:34 INFO - 'USER': 'cltbld', 09:18:34 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', 09:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:34 INFO - '_': '/tools/buildbot/bin/python'} 09:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:37 INFO - Downloading docopt-0.6.1.tar.gz 09:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:37 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:37 INFO - Running setup.py install for blobuploader 09:18:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:37 INFO - Running setup.py install for requests 09:18:38 INFO - Running setup.py install for docopt 09:18:38 INFO - Successfully installed blobuploader requests docopt 09:18:38 INFO - Cleaning up... 09:18:38 INFO - Return code: 0 09:18:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:38 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d3b0>, '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 0x2d5e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e740>, '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': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', '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 09:18:38 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 09:18:38 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 09:18:38 INFO - Using env: {'DISPLAY': ':0', 09:18:38 INFO - 'HOME': '/home/cltbld', 09:18:38 INFO - 'LANG': 'en_US.UTF-8', 09:18:38 INFO - 'LANGUAGE': 'en_US:en', 09:18:38 INFO - 'LOGNAME': 'cltbld', 09:18:38 INFO - 'MAIL': '/var/mail/cltbld', 09:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:38 INFO - 'MOZ_NO_REMOTE': '1', 09:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:38 INFO - 'NO_EM_RESTART': '1', 09:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:38 INFO - 'PWD': '/builds/slave/test', 09:18:38 INFO - 'SHELL': '/bin/bash', 09:18:38 INFO - 'SHLVL': '1', 09:18:38 INFO - 'TERM': 'linux', 09:18:38 INFO - 'TMOUT': '86400', 09:18:38 INFO - 'USER': 'cltbld', 09:18:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', 09:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:38 INFO - '_': '/tools/buildbot/bin/python'} 09:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:38 INFO - Running setup.py (path:/tmp/pip-WZRJfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:38 INFO - Running setup.py (path:/tmp/pip-7IGb0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:38 INFO - Running setup.py (path:/tmp/pip-HYe6Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:38 INFO - Running setup.py (path:/tmp/pip-_ENXVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:38 INFO - Running setup.py (path:/tmp/pip-W1AeNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:38 INFO - Running setup.py (path:/tmp/pip-oVDjn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:39 INFO - Running setup.py (path:/tmp/pip-E4MAit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:39 INFO - Running setup.py (path:/tmp/pip-zDySCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:39 INFO - Running setup.py (path:/tmp/pip-JVn7_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:39 INFO - Running setup.py (path:/tmp/pip-X82bGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:39 INFO - Running setup.py (path:/tmp/pip-igK86X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:39 INFO - Running setup.py (path:/tmp/pip-JmZzye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:39 INFO - Running setup.py (path:/tmp/pip-Sn6KK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:39 INFO - Running setup.py (path:/tmp/pip-xtS43u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:39 INFO - Running setup.py (path:/tmp/pip-t3ueba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:39 INFO - Running setup.py (path:/tmp/pip-mElWVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:39 INFO - Running setup.py (path:/tmp/pip-v0yyi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:39 INFO - Running setup.py install for manifestparser 09:18:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:39 INFO - Running setup.py install for mozcrash 09:18:40 INFO - Running setup.py install for mozdebug 09:18:40 INFO - Running setup.py install for mozdevice 09:18:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:40 INFO - Running setup.py install for mozfile 09:18:40 INFO - Running setup.py install for mozhttpd 09:18:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:40 INFO - Running setup.py install for mozinfo 09:18:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:18:40 INFO - Running setup.py install for mozInstall 09:18:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:18:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:18:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:18:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:18:40 INFO - Running setup.py install for mozleak 09:18:40 INFO - Running setup.py install for mozlog 09:18:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:18:40 INFO - Running setup.py install for moznetwork 09:18:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:40 INFO - Running setup.py install for mozprocess 09:18:41 INFO - Running setup.py install for mozprofile 09:18:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:41 INFO - Running setup.py install for mozrunner 09:18:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:18:41 INFO - Running setup.py install for mozscreenshot 09:18:41 INFO - Running setup.py install for moztest 09:18:41 INFO - Running setup.py install for mozversion 09:18:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:18:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:18:41 INFO - Cleaning up... 09:18:41 INFO - Return code: 0 09:18:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:41 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d3b0>, '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 0x2d5e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e740>, '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': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', '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 09:18:41 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 09:18:41 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 09:18:41 INFO - Using env: {'DISPLAY': ':0', 09:18:41 INFO - 'HOME': '/home/cltbld', 09:18:41 INFO - 'LANG': 'en_US.UTF-8', 09:18:41 INFO - 'LANGUAGE': 'en_US:en', 09:18:41 INFO - 'LOGNAME': 'cltbld', 09:18:41 INFO - 'MAIL': '/var/mail/cltbld', 09:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:41 INFO - 'MOZ_NO_REMOTE': '1', 09:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:41 INFO - 'NO_EM_RESTART': '1', 09:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:41 INFO - 'PWD': '/builds/slave/test', 09:18:41 INFO - 'SHELL': '/bin/bash', 09:18:41 INFO - 'SHLVL': '1', 09:18:41 INFO - 'TERM': 'linux', 09:18:41 INFO - 'TMOUT': '86400', 09:18:41 INFO - 'USER': 'cltbld', 09:18:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', 09:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:41 INFO - '_': '/tools/buildbot/bin/python'} 09:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:41 INFO - Running setup.py (path:/tmp/pip-f4dDXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:41 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)) 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:41 INFO - Running setup.py (path:/tmp/pip-S0vhv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:41 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)) 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:41 INFO - Running setup.py (path:/tmp/pip-_8xfAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:42 INFO - Running setup.py (path:/tmp/pip-70FZuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:42 INFO - Running setup.py (path:/tmp/pip-otSUas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:42 INFO - Running setup.py (path:/tmp/pip-eICiCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:42 INFO - Running setup.py (path:/tmp/pip-dgvaPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:42 INFO - Running setup.py (path:/tmp/pip-HrdqMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:42 INFO - Running setup.py (path:/tmp/pip-G5F2j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:42 INFO - Running setup.py (path:/tmp/pip-ByD6h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:42 INFO - Running setup.py (path:/tmp/pip-Gd2U9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:42 INFO - Running setup.py (path:/tmp/pip-Ueqem_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:42 INFO - Running setup.py (path:/tmp/pip-RG1kkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:42 INFO - Running setup.py (path:/tmp/pip-I2rLiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:42 INFO - Running setup.py (path:/tmp/pip-fzUZow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:42 INFO - Running setup.py (path:/tmp/pip-J33NhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:42 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)) 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:42 INFO - Running setup.py (path:/tmp/pip-tam3kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:43 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)) 09:18:43 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)) 09:18:43 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)) 09:18:43 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)) 09:18:43 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)) 09:18:43 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)) 09:18:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:44 INFO - Downloading blessings-1.6.tar.gz 09:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:18:45 INFO - Installing collected packages: blessings 09:18:45 INFO - Running setup.py install for blessings 09:18:45 INFO - Successfully installed blessings 09:18:45 INFO - Cleaning up... 09:18:45 INFO - Return code: 0 09:18:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:45 INFO - Reading from file tmpfile_stdout 09:18:45 INFO - Current package versions: 09:18:45 INFO - argparse == 1.2.1 09:18:45 INFO - blessings == 1.6 09:18:45 INFO - blobuploader == 1.2.4 09:18:45 INFO - docopt == 0.6.1 09:18:45 INFO - functools32 == 3.2.3-2 09:18:45 INFO - jsonschema == 2.5.1 09:18:45 INFO - manifestparser == 1.1 09:18:45 INFO - mozInstall == 1.12 09:18:45 INFO - mozcrash == 0.17 09:18:45 INFO - mozdebug == 0.1 09:18:45 INFO - mozdevice == 0.48 09:18:45 INFO - mozfile == 1.2 09:18:45 INFO - mozhttpd == 0.7 09:18:45 INFO - mozinfo == 0.9 09:18:45 INFO - mozleak == 0.1 09:18:45 INFO - mozlog == 3.2 09:18:45 INFO - moznetwork == 0.27 09:18:45 INFO - mozprocess == 0.22 09:18:45 INFO - mozprofile == 0.28 09:18:45 INFO - mozrunner == 6.11 09:18:45 INFO - mozscreenshot == 0.1 09:18:45 INFO - mozsystemmonitor == 0.3 09:18:45 INFO - moztest == 0.7 09:18:45 INFO - mozversion == 1.4 09:18:45 INFO - psutil == 3.1.1 09:18:45 INFO - requests == 1.2.3 09:18:45 INFO - wsgiref == 0.1.2 09:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:45 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d3b0>, '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 0x2d5e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e740>, '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': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', '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 09:18:45 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 09:18:45 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 09:18:45 INFO - Using env: {'DISPLAY': ':0', 09:18:45 INFO - 'HOME': '/home/cltbld', 09:18:45 INFO - 'LANG': 'en_US.UTF-8', 09:18:45 INFO - 'LANGUAGE': 'en_US:en', 09:18:45 INFO - 'LOGNAME': 'cltbld', 09:18:45 INFO - 'MAIL': '/var/mail/cltbld', 09:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:45 INFO - 'MOZ_NO_REMOTE': '1', 09:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:45 INFO - 'NO_EM_RESTART': '1', 09:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:45 INFO - 'PWD': '/builds/slave/test', 09:18:45 INFO - 'SHELL': '/bin/bash', 09:18:45 INFO - 'SHLVL': '1', 09:18:45 INFO - 'TERM': 'linux', 09:18:45 INFO - 'TMOUT': '86400', 09:18:45 INFO - 'USER': 'cltbld', 09:18:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', 09:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:45 INFO - '_': '/tools/buildbot/bin/python'} 09:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:45 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)) 09:18:45 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)) 09:18:45 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)) 09:18:45 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)) 09:18:45 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)) 09:18:45 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)) 09:18:45 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)) 09:18:45 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)) 09:18:45 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)) 09:18:45 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)) 09:18:45 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)) 09:18:45 INFO - Cleaning up... 09:18:45 INFO - Return code: 0 09:18:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:45 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d3b0>, '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 0x2d5e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e740>, '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': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', '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 09:18:45 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 09:18:45 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 09:18:45 INFO - Using env: {'DISPLAY': ':0', 09:18:45 INFO - 'HOME': '/home/cltbld', 09:18:45 INFO - 'LANG': 'en_US.UTF-8', 09:18:45 INFO - 'LANGUAGE': 'en_US:en', 09:18:45 INFO - 'LOGNAME': 'cltbld', 09:18:45 INFO - 'MAIL': '/var/mail/cltbld', 09:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:45 INFO - 'MOZ_NO_REMOTE': '1', 09:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:45 INFO - 'NO_EM_RESTART': '1', 09:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:45 INFO - 'PWD': '/builds/slave/test', 09:18:45 INFO - 'SHELL': '/bin/bash', 09:18:45 INFO - 'SHLVL': '1', 09:18:45 INFO - 'TERM': 'linux', 09:18:45 INFO - 'TMOUT': '86400', 09:18:45 INFO - 'USER': 'cltbld', 09:18:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', 09:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:45 INFO - '_': '/tools/buildbot/bin/python'} 09:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:18:45 INFO - Cleaning up... 09:18:45 INFO - Return code: 0 09:18:45 INFO - Running post-action listener: _resource_record_post_action 09:18:45 INFO - Running post-action listener: _start_resource_monitoring 09:18:45 INFO - Starting resource monitoring. 09:18:45 INFO - ##### 09:18:45 INFO - ##### Finished create-virtualenv step (success) 09:18:45 INFO - ##### 09:18:45 INFO - ##### 09:18:45 INFO - ##### Running install step. 09:18:45 INFO - ##### 09:18:45 INFO - Running pre-action listener: _resource_record_pre_action 09:18:45 INFO - Running main action method: install 09:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:46 INFO - Reading from file tmpfile_stdout 09:18:46 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:46 INFO - Reading from file tmpfile_stdout 09:18:46 INFO - Output received: 09:18:46 INFO - Usage: mozinstall [options] installer 09:18:46 INFO - Options: 09:18:46 INFO - -h, --help show this help message and exit 09:18:46 INFO - -d DEST, --destination=DEST 09:18:46 INFO - Directory to install application into. [default: 09:18:46 INFO - "/builds/slave/test"] 09:18:46 INFO - --app=APP Application being installed. [default: firefox] 09:18:46 INFO - mkdir: /builds/slave/test/build/application 09:18:46 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'] 09:18:46 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 09:19:02 INFO - Reading from file tmpfile_stdout 09:19:02 INFO - Output received: 09:19:02 INFO - /builds/slave/test/build/application/firefox/firefox 09:19:02 INFO - Running post-action listener: _resource_record_post_action 09:19:02 INFO - ##### 09:19:02 INFO - ##### Finished install step (success) 09:19:02 INFO - ##### 09:19:02 INFO - ##### 09:19:02 INFO - ##### Running run-tests step. 09:19:02 INFO - ##### 09:19:02 INFO - Running pre-action listener: _resource_record_pre_action 09:19:02 INFO - Running main action method: run_tests 09:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:02 INFO - Python 2.7.3 09:19:02 INFO - Return code: 0 09:19:02 INFO - grabbing minidump binary from tooltool 09:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:19:02 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 0x2d5d3b0>, '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 0x2d5e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:02 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 09:19:02 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 09:19:02 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 09:19:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:02 INFO - Return code: 0 09:19:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:19:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:19:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:02 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/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:19:02 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/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 09:19:02 INFO - Using env: {'DISPLAY': ':0', 09:19:02 INFO - 'HOME': '/home/cltbld', 09:19:02 INFO - 'LANG': 'en_US.UTF-8', 09:19:02 INFO - 'LANGUAGE': 'en_US:en', 09:19:02 INFO - 'LOGNAME': 'cltbld', 09:19:02 INFO - 'MAIL': '/var/mail/cltbld', 09:19:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:02 INFO - 'MOZ_NO_REMOTE': '1', 09:19:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:02 INFO - 'NO_EM_RESTART': '1', 09:19:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:02 INFO - 'PWD': '/builds/slave/test', 09:19:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:02 INFO - 'SHELL': '/bin/bash', 09:19:02 INFO - 'SHLVL': '1', 09:19:02 INFO - 'TERM': 'linux', 09:19:02 INFO - 'TMOUT': '86400', 09:19:02 INFO - 'USER': 'cltbld', 09:19:02 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746', 09:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:02 INFO - '_': '/tools/buildbot/bin/python'} 09:19:02 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/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:19:02 INFO - mozversion application_buildid: 20160704085124 09:19:02 INFO - mozversion application_changeset: 7eef107d8d310cc5c0419d3fd3bf7f74590da3db 09:19:02 INFO - mozversion application_display_name: Nightly 09:19:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:02 INFO - mozversion application_name: Firefox 09:19:02 INFO - mozversion application_remotingname: firefox 09:19:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:19:02 INFO - mozversion application_vendor: Mozilla 09:19:02 INFO - mozversion application_version: 50.0a1 09:19:02 INFO - mozversion platform_buildid: 20160704085124 09:19:02 INFO - mozversion platform_changeset: 7eef107d8d310cc5c0419d3fd3bf7f74590da3db 09:19:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:19:02 INFO - mozversion platform_version: 50.0a1 09:19:02 INFO - using testdate: 1467649142 09:19:02 INFO - actual date: 1467649142 09:19:02 INFO - starting webserver on 'localhost:52992' 09:19:02 INFO - SUITE-START | Running 2 tests 09:19:02 INFO - TEST-START | dromaeo_css 09:19:02 INFO - operating with platform_type : linux_ 09:19:02 INFO - Initialising browser for dromaeo_css test... 09:19:02 INFO - TEST-INFO | started process 13446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVZ4tO/profile http://localhost:52992/getInfo.html) 09:19:06 INFO - PROCESS | 13446 | __metrics Screen width/height:1600/1200 09:19:06 INFO - PROCESS | 13446 | colorDepth:24 09:19:06 INFO - PROCESS | 13446 | Browser inner width/height: 1024/697 09:19:06 INFO - PROCESS | 13446 | __metrics 09:19:07 INFO - PROCESS | 13446 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:08 INFO - TEST-INFO | 13446: exit 0 09:19:08 INFO - Browser initialized. 09:19:08 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:08 INFO - TEST-INFO | started process 13529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVZ4tO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:20 INFO - PROCESS | 13529 | RSS: Main: 158593024 09:19:20 INFO - PROCESS | 13529 | 09:20:11 INFO - PROCESS | 13529 | 1467649211722 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] 09:22:24 INFO - PROCESS | 13529 | Cycle 1(1): loaded http://localhost:52992/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52992/tests/dromaeo/cssquery-ext.html) 09:22:25 INFO - PROCESS | 13529 | RSS: Main: 262426624 09:22:25 INFO - PROCESS | 13529 | 09:25:28 INFO - PROCESS | 13529 | Cycle 1(1): loaded http://localhost:52992/tests/dromaeo/cssquery-ext.html (next: http://localhost:52992/tests/dromaeo/cssquery-jquery.html) 09:25:29 INFO - PROCESS | 13529 | RSS: Main: 248172544 09:25:29 INFO - PROCESS | 13529 | 09:28:31 INFO - PROCESS | 13529 | Cycle 1(1): loaded http://localhost:52992/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52992/tests/dromaeo/cssquery-mootools.html) 09:28:31 INFO - PROCESS | 13529 | RSS: Main: 240664576 09:28:31 INFO - PROCESS | 13529 | 09:31:34 INFO - PROCESS | 13529 | Cycle 1(1): loaded http://localhost:52992/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52992/tests/dromaeo/cssquery-prototype.html) 09:31:34 INFO - PROCESS | 13529 | RSS: Main: 240898048 09:31:34 INFO - PROCESS | 13529 | 09:34:38 INFO - PROCESS | 13529 | Cycle 1(1): loaded http://localhost:52992/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52992/tests/dromaeo/cssquery-yui.html) 09:34:38 INFO - PROCESS | 13529 | RSS: Main: 219742208 09:34:38 INFO - PROCESS | 13529 | 09:37:41 INFO - PROCESS | 13529 | Cycle 1(1): loaded http://localhost:52992/tests/dromaeo/cssquery-yui.html (next: http://localhost:52992/tests/dromaeo/cssquery-dojo.html) 09:37:41 INFO - PROCESS | 13529 | RSS: Main: 286691328 09:37:41 INFO - PROCESS | 13529 | 09:37:41 INFO - PROCESS | 13529 | __start_tp_report 09:37:41 INFO - PROCESS | 13529 | _x_x_mozilla_page_load 09:37:41 INFO - PROCESS | 13529 | _x_x_mozilla_page_load_details 09:37:41 INFO - PROCESS | 13529 | |i|pagename|runs| 09:37:41 INFO - PROCESS | 13529 | |0;dojo.html;2614.3725505878588;2633.6181253718223;2658.960115598265;2659.654244948157;2676.0366268143466;4668.136394766971;4704.343042359905;4779.235322348425;4783.35424717663;4819.903601927964;4670.416197975253;4718.528147185289;4731.834385796497;4743.644226682995;4744.739039352834;4150.43969064177;4290.678199135062;4398.120375924812;4432.20220360335;4483.193025255453;4412.955870441303;4440.4893437254805;4449.310356894686;4457.955420445803;4491.865244042684;4242.745435273878;4293.978530107361;4322.589354011364;4335.1329734053315;4373.365861950031;4351.369051487517;4360.760158191299;4413.29387298034;4422.181896349153;4423.0711550574415;4386.356644536413;4399.340098985178;4407.911841763179;4447.132809102226;4449.9555004450185;4645.117427688729;4731.313959475857;4815.301781241736;4822.300766388854;4837.7339246341435;5113.642045056848;5167.586593072545;5178.249153872705;5179.870503237412;5180.041692286939;5024.547790698854;5186.0665080285535;5227.738613069331;5228.085085110129;5229.1633338666015;4735.337052812609;4765.11845308619;4772.093302272557;4804.447488538863;4824.95175048245;5297.205419187076;5306.52241298285;5309.8938021239355;5310.575153987672;5313.707746073926;4915.87710307238;4978.303037574742;5051.6716413433005;5076.289319495274;5128.307678463434;5086.593072554261;5104.897902041938;5123.666961647481;5123.820666276662;5172.612054095883;5072.898542029213;5080.568151707146;5096.643234973516;5101.183810590362;5145.536901678867;4934;4999.775010124553;5009;5088.465711100355;5091.261767043832;4378.846740364072;4386.649068074546;4406.801693923781;4441.444819397575;4447.73313601185;3802.885913422602;3829.483019792348;3836.1368692044625;3856.82644281008;3874.9225015499533;4352.630026447788;4352.847650332224;4380.2772542530765;4401.779911004437;4408.845690400821;5084.949150508522;5110.361204849394;5111.284420181178;5143.331366922276;5156.020356132323;4397.428334316518;4406.911861762746;4410.16206920684;4449.310356894686;4456.108778244364;4533.274676051882;4554.726716397026;4600.470945841204;4613.169629466661;4619.122366750306;4765.785539650655;4783.808647654194;4790.904181916412;4799;4841.927371089366;5103.87240318995;5140.691558506502;5141.768620412166;5145.099607568735;5150.0987327216835;4628.560286772751;4658;4670.696404733681;4806.519348065165;4856.465788763304;4934.432540257916;4959.454460009469;4966.130927087673;5012.498750124958;5062.139436295765;5130.102232109441;5153.149730294609;5189.636725429184;5199.11615025439;5200.479952004769;4987.276844857548;4992.475790041994;5000.224965130411;5002.549770520671;5045.419776725724;4858.3441235432765;4904.803807847647;4998.275250088789;5008.098542262282;5013.24801279811;4848.95151048485;4917.582005529427;4924.8768780780765;4966.130927087817;4974.154393753143;5002.974985125051;5003.874903127451;5004.224345226496;5008.348914641073;5050.3434553507805;4732.290156476556;4839.935214252859;4841.491643377394;4916.606671466346;4951.430585482715 09:37:41 INFO - PROCESS | 13529 | |1;ext.html;575.9164921086442;581.7033313010363;582.1355287398213;586.3374386942754;588.2617315269338;27330.86334568327;29854.701452985464;29913.1026069218;40492.39261411074;41717.582824171746;40983.38524922128;41333.58666413335;41524.16951660965;41526.37710434338;41620.79189604055;7816.531008139501;7946.364290856746;7947.761567152995;7957.283844453998;7960.800979975518;7607.885881711751;7768.5338879667115;7791.220877912192;7919.049714034324;7969.681212751512;10140.746481337988;10454.320469169517;10458.372497650165;10747.247692661516;10760.73098172544;10120.595176192943;10207.438590877498;10209.744756381077;10209.948950255239;10210.693679189637;7404.074490688664;9854.21166306701;10089.646862359856;10188.74528136795;10242.743931401774;38219.23561528782;38555.807220963994;38653.806730966164;38679.41980870289;38703;2932.384199318146;2956.127942257039;3063.4638938185726;3098.3803239351996;3304.80171189727;29106.272343191376;29282.853585731937;29285.41429171426;29402.117936461942;29582;3459.60214575322;3490.458978858281;3504.2816222674546;3507.8596856125723;3533.205028868484;259019;259581;259769;260653;261356;52170.21744673833;52821.471785281654;52869.2069618956;52900.206496902574;52925.2061219082;54683.179752303746;54701;54748.45251547434;54758.17862732062;54781.5218478157;14795.630109247355;15094.773578396333;15134.848651513565;15142.242887855564;15218.315175816893;11831.349275789742;11851.88148118525;11882.75231100722;11907.523699052113;11922.046236301248;13306.933465332804;14573.781393279109;14681.706365872622;14786.408543658134;15404.691906162037;5708.343540492813;5805.158252053428;5870.823875283663;5890.293164820249;5941.732622032019;795.6578671171336;863.926566241864;881.0836729801064;908.404994728454;924.3390975452584;28484.287892802844;28530.714692852805;28566.857165714453;28617.427651446855;29088.27279318034;972.4505654305295;974.6101559376165;978.9476312963593;991.6975322526698;1027.198784947742;15321.463748768963;15964.680706385807;16508.6698266034;16739.91630041842;16775.748363774554;383035;386646;387510;387715;389009;50514.494855051715;50756.49243507592;50857;50925.745371273646;51027;1023.5905637744813;1096.7093720164162;1148.3741360958131;1171.5957994491887;1191.582945968904;26227.868860655573;27786.305342366602;28646.140615781558;29447.411051778417;29611.259718507208;48086.27870582014;48250.75874620605;48516.5148348512;48712.26931595958;48730.26904596505;340596;342094;342620;342713;344140;21883.562328753655;24125.552466852045;24597.139100131408;25135.74864251407;25271.115510957763;41188.116831821484;41659.583404166784;42420.151596968506;42448.36327455029;42917.570824292605;35357.469637954935;36092.27815443729;36747.816260918524;37002.814985924895;37373.81313093417;36310.27379452449;36809;37116.443253350684;37219.62780372162;37739;35628.28743425169;35896.10259743423;37494.625053750206;37846.43230351492;39848.402273966494;30819.845900770353;33200;33446.832765836014;33624.327513449105;33930.66069339275;25061.74938250667;25783.226503204933;25927.74072259253;25941.35146621274;25982.380086701553 09:37:41 INFO - PROCESS | 13529 | |2;jquery.html;347.0144788799808;355.67455777963147;369.8705453091418;375.65064490024275;391.6357787257851;13033.41349639266;16382.098984555845;16610.916945415254;17461.563460913483;18407.17167727452;17087.31650733972;17515.2118154683;17829.019403932813;17842.82157178428;18160.81839181608;4961.452561418585;5092.592592592584;5234.450382709818;5249.1338929076655;5249.265102885599;3654.104744337641;4886.926696099544;5154.92267615986;5801.622894511843;6086.7565297388055;6146.047362658773;6173.043178307369;6187.195664563623;6188.164597779287;6188.319284878659;6000.069989151667;6159.630422174684;6204.47261982732;6224.595401298901;6230.532710046765;3356.7314614831;3527.400341941876;3530.0468873404293;5440.619156659035;5446.700431476267;18880.43358699241;20889.37331880046;21008.684869726967;22030.779692203032;22259.109635614557;1881.8870867747842;1884.3122260375;1889.3670620342202;2230.520438105799;2555.1440267510407;13224.471021159143;13334.399952002183;13471.12437691547;13622.114562553403;13837.654058648513;1681.6132289573466;1733.4886208568503;1799.9280028798833;1824.2155872974615;1832.0564909071707;70744.6462767688;71511.28488715098;72076.6396168021;73004.63497682531;73369;8736.650533978569;8880.245179159843;9216.907830921738;9252.95373523128;10124.291299608956;13269.07116501855;13778;13794.448222071005;13827.723445531034;13855.653608659864;7390.7413240536325;7396.149442814038;7490.288422599844;7529.623518824037;7630.961845190738;7013.403860671798;7228.060352154186;7321.890171647429;7350.705971761176;7433.4053275737815;6332.651704156316;6360.681965901686;6380.936190638127;6462.642845002602;6484.773032943919;1734.2282684205659;1773.3881810775263;1776.9200385982404;1790.0756686561738;1817.681905666503;798.2017982017982;816.3550794872103;836.6323305046703;927.8190752803139;953.1469334945324;17551.385701500643;17889.642207155783;18197.818021819876;18245.7263141053;18317.17572709231;855.7561095087995;878.9824203516022;884.4516399832145;894.8478758611052;962.7063745557672;9804.411735295906;10175.542100605491;10367.118794902517;10392.272540922062;10500.00249976251;382651;399852;406960;407938;408699;45125.77437112859;72644;74595;74721;74906.30754950162;911.6080085563138;918.0589895357313;918.0956757593765;920.1120918313993;926.9026752191057;16010.519684409486;16157.919210404343;16201.351945922032;16267.349306027627;16294.185290735653;28022.71977280201;33298;34422.31155376929;37400.62599373971;37470;46594.534054659016;46700.299495506915;46822.29766553437;47136;47348.76325618487;7720.652570634223;7887.171846955987;7929.960350198212;7930.841383172419;8084.959575202086;11696.70758231051;12061.216020958609;12069.939650301692;12476.812847807108;12671.556495522613;9958.452285124387;10381.221408394249;10456.05895469381;10468;11123.888761112285;10496.317739346918;10672.83990740155;10841.241113122005;11065.170112241452;11111.777764444827;10884.782304354027;10913.83629245546;11073;11119.166062545502;11171.05046071093;6653.434458071119;6937.7571784987285;7140.143182818095;7406.851862962818;8171.673133074848;9047.68333108338;10363.896361036293;10418.062374386342;10471.371717696962;10490.108340791117 09:37:41 INFO - PROCESS | 13529 | |3;mootools.html;1391.756442622541;1428.31440908364;1454.4763885001398;1694.4747128390193;1720.9999999999993;7540.886886696704;7986.241307075833;8070.354371650268;8084.555349455785;8089.716859909911;6707.496937729666;6941.583504989704;6946.097007389045;7116.039334689828;7879.251471110249;2143.699882016515;2224.744154422246;2239.652853807654;2251.6284813005836;2256.255435706213;2237.8097861681777;2238.6418173092306;2259.48031952651;2262.2082271205113;2277.339571524256;1865.4590168851016;2155.137944822068;2240.8543444676125;2244.955100897981;2251.34710933829;2161.502854343502;2194.967075493869;2197.3407977606653;2197.7252843394576;2199.285232299509;2169.4142581502906;2175.5213852952484;2221.0116498158327;2226.365485836529;2232.352617740853;7966.800829979297;8021.5989200540325;8034.718784842503;8037.799055023671;8043.678252869879;4515.977420112911;4608.055348653518;4648.302754586805;4654.208784506642;4657.697249678794;2861.141657502741;2861.4992376334267;2910.3742695320607;2961.614990051301;2975.538791487323;937.6436953957452;963.2534785541261;963.6675347005272;971.4365667912593;1626;10237.129843963272;10496.632617858415;10509.527071281811;10615.628453004108;10620.415877126756;3912.178442527101;4051.6353528182603;4125.381192821101;4130.256553820341;4132.876013719593;8415;8448.281896038905;8462.746117616482;8464.32285417165;8470.618822153017;4546.1135078659345;4567.771611419482;4571.291449825282;4571.679982401267;4577.5193604671695;3728.4034554471154;3792.943105853414;4266.2960611499375;4275.337322714922;4284.357346398066;3388.423967925459;3507.2459421224557;3518.876839310663;3520.8063556504126;3528.1356067763563;1063.473580577619;1065.4832406282947;1081.1512962324537;1102.0962810495316;1104.9337039777638;844.3414136973171;861.3238607692931;861.573521107056;885.6191837509804;897.1701176411793;5269.841904742864;5373.7581808818695;5389.946100538945;5692.089265717548;5788.88422231553;807.2129673568224;827.1604321613567;852.4501696405783;893.3657103456619;926.3515539122641;3584.1577229351083;3710.4434334849448;3725.776453412804;3753.3886142560973;3767.7927713975446;9465.242780577537;9718.514074296398;9832.360896541702;9895.158911492459;9920.652777152765;9801.019898010141;9811;9817.312788104908;9833.950830245803;9866.605335786631;7305.305995930378;7417.740379086598;7420.332170104716;7422.331990120915;7441.962790186123;5327.520523152934;5362.410134885237;5416.485433883775;5553.111502159635;5650.85872853182;8711.651533938824;9055.592498337459;9095.226905713089;9185.586648600696;9350.579223935076;7957.801054973672;8629.266512346521;9097.59060842277;9310.255179585753;9415.05849415053;7191.316824901626;7500.812479688051;7535.54786712799;7538.811529711801;7669.69321227167;7324.121105467378;7620.237976202336;7639.388848892187;7645.694172233271;7651.655675494728;6895.6552172392185;6934.618595977068;7008.964955175192;7029.648517573998;7171.318724721144;6856.280090590416;6904.551204171713;6934.757283495053;6963.373296403348;7021.227664956953;6454.870902582016;6489.772857949949;6516.348365163635;6519.902201467076;6536.6731663415685;4557.819739923325;4624.907501850012;4752.477227504903;4808.374911261653;4810.63920205993;4791.784369703441;4804.711717296974;4809.759512024455;4826;4904.313396124617 09:37:41 INFO - PROCESS | 13529 | |4;prototype.html;301.5281085101817;309.7816039692017;312.62172770947154;313.99372012559763;316.61847473794074;4837.758112094394;4879.194932836087;4879.9756001219985;4886.43805962314;4903.725031491811;4784.091022705684;4805.375301210846;4852.5147485251455;4856.878578035551;4862.173430516812;3672.7979961102196;3768.56927281903;3803.82882770276;3853.5953724858905;3879.5538513071074;3829.5021647185968;3835.6356146166067;3878.1661942682317;3885.358915778893;3914.1193231522966;3804.410316400962;3832.156925476391;3832.482614846988;3837.9424308635394;3852.845886164564;3658.579263384705;3715.1640880801874;3802.714796390254;3823.388257878754;3850.4416859555486;3430.5711786026745;3436.9828150859084;3440.82795860206;3443.3974054540354;3443.483477478373;4777.140114779339;4777.355057067286;4777.474477807438;4779.115863565252;4789.473157952622;4139.710220284551;4295.248331541968;4332.566743325642;4408.096340250241;4416.3596278539435;5100.974495127501;5103.4896510349035;5105.463926287761;5120.871978200537;5133.768980395891;3657.305112028706;3661.7802931824176;3668.486411902336;3669.6513831185994;3673.210259794157;5035.194368900959;5340.599455040888;5360.785568577252;5364.202991997686;5386.841829006743;3682.1531047858607;3689.3912504436466;3694.8569829498824;3695.630436956337;3712.276106159273;3737.588865224823;3763.2097259575794;3767.095896984759;3771.453139294787;3773.6226377362045;4297.957020429818;4310.374995625617;4321.611055005064;4325.589069038437;4329.653627709776;4968.826091086795;5033.84898453047;5080.872978175576;5110.616703747234;5128.589712822965;1280.8527019392702;1300.0639539531521;1300.219868079145;1300.8048792680984;1302.0625149892253;827.2967977219436;827.6192951242496;847.9788005299794;855.422589751915;873.0527377795037;4457.353683715908;4485.641148708096;4488.259437192826;4494.977525112354;4501.977490112528;5170.482951704875;5172.19830926207;5202.24567437727;5230.927659829726;5264.763085661154;4326.394304797331;4417.889552761207;4420.84527041552;4454.22051141049;4458.77706114693;2785.8607069646437;2791.6231308773054;2798.188525327673;2804.3314228034287;2810.3114736889593;4930.11257973561;4930.767308172957;4943.703377797272;4950.950490495121;4964.329815474937;5129.256257842592;5391.757370918318;5393.894251678396;5397.217403476474;5399.163129714901;4920.852374428701;4954.727489988085;4959.2065269557415;4962.900741985212;4967.602591792648;5266.78932842682;5272;5277;5277.973610131925;5283.89432211346;4914.34625302347;5192.597998540448;5204.193350030751;5204.7918083276245;5212;4955.776990035385;4962.578180854668;4970.210724139235;4970.552650261494;4977.825776097964;3765.1340191755503;3795.544534655859;3807.8857634271017;3811.485449464287;3818.980905095457;5168.250603662523;5291.603129765206;5316.989771943473;5371.958655710805;5382.515573598395;5138.7923837897315;5140.948590514047;5145.202493613496;5153.561947234377;5156.20078887773;5154.252633368215;5155.175171972466;5173.63784535094;5193.298904647975;5197.402298735694;4937.8271760488215;5082.872928176826;5092.879566495365;5093.388793344822;5145.610685115073;4943.728094954812;5044.596432285482;5127.92308115386;5156.56169225605;5171.250168725439;5075.609597698039;5090.592752579711;5091.694498330112;5099.337086178922;5099.92350114756 09:37:41 INFO - PROCESS | 13529 | |5;yui.html;647.9902801457978;682.9795106146818;723.334532230348;727.2291371146586;746.4215233194274;12797.104202705814;13671.179729216254;13676.384562694679;13706.520271790489;13717.108387954777;12098.516059357615;12206.572769953053;12294.63116106516;12614.36928153591;13148.408321625526;762.1616222155626;780.0717146595562;783.1385475976409;784.1296161260996;785.4305628419407;622.1476577089394;764.3579393309619;787.4684587903142;797.3222760653456;800.0599295827409;831.55096248026;834.4284165346727;834.7328854766478;834.7620928035511;835.2566216067704;643.1414062226933;835.715856608756;835.7868743470407;836.1805430677908;837.5016864965366;587.8794847056344;604.1511676095093;605.6699098991061;605.7819185093363;606.3784620763709;13124.803127953088;13126.934365328209;13135.934320328433;13139.343032848416;13148.276844773534;12005.57980470688;12318.384080795924;12491.75016499674;12525.812112818225;12638.178518396275;11407.372594507298;11751.882481175164;11833.763324733458;11997.580084697081;12249.755004899942;4087.3255912774357;4115.36211887158;4143.316352801784;4160.750354978711;4176.206520761046;54902.45097549013;55197.1720424194;55309;55474.72262638661;56823.71588142033;9805.509724513746;10006;10148.746281342877;10165.186785057178;10476.895231047745;18567.90716046411;18579.163937622838;18585.44243672692;18595.44213673592;18601.348952786586;6898.724051037902;6957.234704182536;6964.233934267227;6999.650017499104;7004.124484439445;3533.4699795030438;3567.4113771227458;3716.758410703296;3795.6204379562373;3796.145867179918;2896;3015.487367147546;3018.683038280949;3025.3797971415806;3037.2255074955747;487.04539103357814;496.1317694035438;497.07295893159;497.8182963218399;499.3757802746567;466.37272867992493;532.7895481284871;535.3014316317243;536.085973415326;581.0325807530498;7675.424343174284;7808.726694565663;7880;7895.249951254622;8083.436801589272;471.9811207551728;473.69210013491505;488.7336401661103;515.9886622220415;548.7914592454921;3862.671672907778;3918.6081391861157;3960.089179488734;4121.093359460914;4122.3404255319;57751;94847.52576237213;97016;97641.02358976462;97780;85748.14251857526;86726.56636716903;87701.56149219214;87718;87797;77715;78431;79825;80404.19595804084;80639.59680201561;7415.3326200642205;7553.164998256798;7727.227277272228;7767.155258147253;7998.080220774686;43486.56513434825;43957.12085758203;44800.55199448094;45276.77361613171;46258.30612540747;41595;58453.4154658465;64782;65400;65974.67012664906;10856.45717714127;11261.549538018715;11453.312801231952;12070.939645301718;12140.15018948665;12442.253464792142;12751.808722868978;13068.80396794068;13119.147255428366;13545.59363219105;11905.464254108412;12608.432620531914;12637.810432843698;12939.094263401472;12954.740905182032;10656.10432466284;11311.751636520805;11504.309741415542;12138.817917731065;12199.87800122023;12566.748665026831;13110.672233194246;13424.39590218462;13440.327983600977;13495.527656531975;10545.630902918361;10662.946685266834;10874.456277186267;11044.447777611247;11129.276597021168;10147.695569132939;10203.336783109075;10297.691069267934;10418.531166097393;10639.521221544894 09:37:41 INFO - PROCESS | 13529 | __end_tp_report 09:37:41 INFO - PROCESS | 13529 | __start_cc_report 09:37:41 INFO - PROCESS | 13529 | _x_x_mozilla_cycle_collect,948 09:37:41 INFO - PROCESS | 13529 | __end_cc_report 09:37:41 INFO - PROCESS | 13529 | __startTimestamp1467650261718__endTimestamp 09:37:41 INFO - PROCESS | 13529 | 09:37:41 INFO - PROCESS | 13529 | ------- Summary: start ------- 09:37:41 INFO - PROCESS | 13529 | Number of tests: 6 09:37:41 INFO - PROCESS | 13529 | 09:37:41 INFO - PROCESS | 13529 | [#0] dojo.html Cycles:165 Average:4723.15 Median:4824.95 stddev:499.58 (10.4%) stddev-sans-first:472.93 09:37:41 INFO - PROCESS | 13529 | Values: 2614.4 2633.6 2659.0 2659.7 2676.0 4668.1 4704.3 4779.2 4783.4 4819.9 4670.4 4718.5 4731.8 4743.6 4744.7 4150.4 4290.7 4398.1 4432.2 4483.2 4413.0 4440.5 4449.3 4458.0 4491.9 4242.7 4294.0 4322.6 4335.1 4373.4 4351.4 4360.8 4413.3 4422.2 4423.1 4386.4 4399.3 4407.9 4447.1 4450.0 4645.1 4731.3 4815.3 4822.3 4837.7 5113.6 5167.6 5178.2 5179.9 5180.0 5024.5 5186.1 5227.7 5228.1 5229.2 4735.3 4765.1 4772.1 4804.4 4825.0 5297.2 5306.5 5309.9 5310.6 5313.7 4915.9 4978.3 5051.7 5076.3 5128.3 5086.6 5104.9 5123.7 5123.8 5172.6 5072.9 5080.6 5096.6 5101.2 5145.5 4934.0 4999.8 5009.0 5088.5 5091.3 4378.8 4386.6 4406.8 4441.4 4447.7 3802.9 3829.5 3836.1 3856.8 3874.9 4352.6 4352.8 4380.3 4401.8 4408.8 5084.9 5110.4 5111.3 5143.3 5156.0 4397.4 4406.9 4410.2 4449.3 4456.1 4533.3 4554.7 4600.5 4613.2 4619.1 4765.8 4783.8 4790.9 4799.0 4841.9 5103.9 5140.7 5141.8 5145.1 5150.1 4628.6 4658.0 4670.7 4806.5 4856.5 4934.4 4959.5 4966.1 5012.5 5062.1 5130.1 5153.1 5189.6 5199.1 5200.5 4987.3 4992.5 5000.2 5002.5 5045.4 4858.3 4904.8 4998.3 5008.1 5013.2 4849.0 4917.6 4924.9 4966.1 4974.2 5003.0 5003.9 5004.2 5008.3 5050.3 4732.3 4839.9 4841.5 4916.6 4951.4 09:37:41 INFO - PROCESS | 13529 | 09:37:41 INFO - PROCESS | 13529 | [#1] ext.html Cycles:180 Average:48664.30 Median:3520.53 stddev:87864.55 (2495.8%) stddev-sans-first:88036.85 09:37:41 INFO - PROCESS | 13529 | Values: 575.9 581.7 582.1 586.3 588.3 27330.9 29854.7 29913.1 40492.4 41717.6 40983.4 41333.6 41524.2 41526.4 41620.8 7816.5 7946.4 7947.8 7957.3 7960.8 7607.9 7768.5 7791.2 7919.0 7969.7 10140.7 10454.3 10458.4 10747.2 10760.7 10120.6 10207.4 10209.7 10209.9 10210.7 7404.1 9854.2 10089.6 10188.7 10242.7 38219.2 38555.8 38653.8 38679.4 38703.0 2932.4 2956.1 3063.5 3098.4 3304.8 29106.3 29282.9 29285.4 29402.1 29582.0 3459.6 3490.5 3504.3 3507.9 3533.2 259019.0 259581.0 259769.0 260653.0 261356.0 52170.2 52821.5 52869.2 52900.2 52925.2 54683.2 54701.0 54748.5 54758.2 54781.5 14795.6 15094.8 15134.8 15142.2 15218.3 11831.3 11851.9 11882.8 11907.5 11922.0 13306.9 14573.8 14681.7 14786.4 15404.7 5708.3 5805.2 5870.8 5890.3 5941.7 795.7 863.9 881.1 908.4 924.3 28484.3 28530.7 28566.9 28617.4 29088.3 972.5 974.6 978.9 991.7 1027.2 15321.5 15964.7 16508.7 16739.9 16775.7 383035.0 386646.0 387510.0 387715.0 389009.0 50514.5 50756.5 50857.0 50925.7 51027.0 1023.6 1096.7 1148.4 1171.6 1191.6 26227.9 27786.3 28646.1 29447.4 29611.3 48086.3 48250.8 48516.5 48712.3 48730.3 340596.0 342094.0 342620.0 342713.0 344140.0 21883.6 24125.6 24597.1 25135.7 25271.1 41188.1 41659.6 42420.2 42448.4 42917.6 35357.5 36092.3 36747.8 37002.8 37373.8 36310.3 36809.0 37116.4 37219.6 37739.0 35628.3 35896.1 37494.6 37846.4 39848.4 30819.8 33200.0 33446.8 33624.3 33930.7 25061.7 25783.2 25927.7 25941.4 25982.4 09:37:41 INFO - PROCESS | 13529 | 09:37:41 INFO - PROCESS | 13529 | [#2] jquery.html Cycles:180 Average:24594.49 Median:191513.33 stddev:65990.58 (34.5%) stddev-sans-first:66150.59 09:37:41 INFO - PROCESS | 13529 | Values: 347.0 355.7 369.9 375.7 391.6 13033.4 16382.1 16610.9 17461.6 18407.2 17087.3 17515.2 17829.0 17842.8 18160.8 4961.5 5092.6 5234.5 5249.1 5249.3 3654.1 4886.9 5154.9 5801.6 6086.8 6146.0 6173.0 6187.2 6188.2 6188.3 6000.1 6159.6 6204.5 6224.6 6230.5 3356.7 3527.4 3530.0 5440.6 5446.7 18880.4 20889.4 21008.7 22030.8 22259.1 1881.9 1884.3 1889.4 2230.5 2555.1 13224.5 13334.4 13471.1 13622.1 13837.7 1681.6 1733.5 1799.9 1824.2 1832.1 70744.6 71511.3 72076.6 73004.6 73369.0 8736.7 8880.2 9216.9 9253.0 10124.3 13269.1 13778.0 13794.4 13827.7 13855.7 7390.7 7396.1 7490.3 7529.6 7631.0 7013.4 7228.1 7321.9 7350.7 7433.4 6332.7 6360.7 6380.9 6462.6 6484.8 1734.2 1773.4 1776.9 1790.1 1817.7 798.2 816.4 836.6 927.8 953.1 17551.4 17889.6 18197.8 18245.7 18317.2 855.8 879.0 884.5 894.8 962.7 9804.4 10175.5 10367.1 10392.3 10500.0 382651.0 399852.0 406960.0 407938.0 408699.0 45125.8 72644.0 74595.0 74721.0 74906.3 911.6 918.1 918.1 920.1 926.9 16010.5 16157.9 16201.4 16267.3 16294.2 28022.7 33298.0 34422.3 37400.6 37470.0 46594.5 46700.3 46822.3 47136.0 47348.8 7720.7 7887.2 7930.0 7930.8 8085.0 11696.7 12061.2 12069.9 12476.8 12671.6 9958.5 10381.2 10456.1 10468.0 11123.9 10496.3 10672.8 10841.2 11065.2 11111.8 10884.8 10913.8 11073.0 11119.2 11171.1 6653.4 6937.8 7140.1 7406.9 8171.7 9047.7 10363.9 10418.1 10471.4 10490.1 09:37:41 INFO - PROCESS | 13529 | 09:37:41 INFO - PROCESS | 13529 | [#3] mootools.html Cycles:180 Average:5192.22 Median:5403.22 stddev:2881.16 (53.3%) stddev-sans-first:2875.09 09:37:41 INFO - PROCESS | 13529 | Values: 1391.8 1428.3 1454.5 1694.5 1721.0 7540.9 7986.2 8070.4 8084.6 8089.7 6707.5 6941.6 6946.1 7116.0 7879.3 2143.7 2224.7 2239.7 2251.6 2256.3 2237.8 2238.6 2259.5 2262.2 2277.3 1865.5 2155.1 2240.9 2245.0 2251.3 2161.5 2195.0 2197.3 2197.7 2199.3 2169.4 2175.5 2221.0 2226.4 2232.4 7966.8 8021.6 8034.7 8037.8 8043.7 4516.0 4608.1 4648.3 4654.2 4657.7 2861.1 2861.5 2910.4 2961.6 2975.5 937.6 963.3 963.7 971.4 1626.0 10237.1 10496.6 10509.5 10615.6 10620.4 3912.2 4051.6 4125.4 4130.3 4132.9 8415.0 8448.3 8462.7 8464.3 8470.6 4546.1 4567.8 4571.3 4571.7 4577.5 3728.4 3792.9 4266.3 4275.3 4284.4 3388.4 3507.2 3518.9 3520.8 3528.1 1063.5 1065.5 1081.2 1102.1 1104.9 844.3 861.3 861.6 885.6 897.2 5269.8 5373.8 5389.9 5692.1 5788.9 807.2 827.2 852.5 893.4 926.4 3584.2 3710.4 3725.8 3753.4 3767.8 9465.2 9718.5 9832.4 9895.2 9920.7 9801.0 9811.0 9817.3 9834.0 9866.6 7305.3 7417.7 7420.3 7422.3 7442.0 5327.5 5362.4 5416.5 5553.1 5650.9 8711.7 9055.6 9095.2 9185.6 9350.6 7957.8 8629.3 9097.6 9310.3 9415.1 7191.3 7500.8 7535.5 7538.8 7669.7 7324.1 7620.2 7639.4 7645.7 7651.7 6895.7 6934.6 7009.0 7029.6 7171.3 6856.3 6904.6 6934.8 6963.4 7021.2 6454.9 6489.8 6516.3 6519.9 6536.7 4557.8 4624.9 4752.5 4808.4 4810.6 4791.8 4804.7 4809.8 4826.0 4904.3 09:37:41 INFO - PROCESS | 13529 | 09:37:41 INFO - PROCESS | 13529 | [#4] prototype.html Cycles:180 Average:4252.69 Median:4870.68 stddev:1233.32 (25.3%) stddev-sans-first:1200.60 09:37:41 INFO - PROCESS | 13529 | Values: 301.5 309.8 312.6 314.0 316.6 4837.8 4879.2 4880.0 4886.4 4903.7 4784.1 4805.4 4852.5 4856.9 4862.2 3672.8 3768.6 3803.8 3853.6 3879.6 3829.5 3835.6 3878.2 3885.4 3914.1 3804.4 3832.2 3832.5 3837.9 3852.8 3658.6 3715.2 3802.7 3823.4 3850.4 3430.6 3437.0 3440.8 3443.4 3443.5 4777.1 4777.4 4777.5 4779.1 4789.5 4139.7 4295.2 4332.6 4408.1 4416.4 5101.0 5103.5 5105.5 5120.9 5133.8 3657.3 3661.8 3668.5 3669.7 3673.2 5035.2 5340.6 5360.8 5364.2 5386.8 3682.2 3689.4 3694.9 3695.6 3712.3 3737.6 3763.2 3767.1 3771.5 3773.6 4298.0 4310.4 4321.6 4325.6 4329.7 4968.8 5033.8 5080.9 5110.6 5128.6 1280.9 1300.1 1300.2 1300.8 1302.1 827.3 827.6 848.0 855.4 873.1 4457.4 4485.6 4488.3 4495.0 4502.0 5170.5 5172.2 5202.2 5230.9 5264.8 4326.4 4417.9 4420.8 4454.2 4458.8 2785.9 2791.6 2798.2 2804.3 2810.3 4930.1 4930.8 4943.7 4951.0 4964.3 5129.3 5391.8 5393.9 5397.2 5399.2 4920.9 4954.7 4959.2 4962.9 4967.6 5266.8 5272.0 5277.0 5278.0 5283.9 4914.3 5192.6 5204.2 5204.8 5212.0 4955.8 4962.6 4970.2 4970.6 4977.8 3765.1 3795.5 3807.9 3811.5 3819.0 5168.3 5291.6 5317.0 5372.0 5382.5 5138.8 5140.9 5145.2 5153.6 5156.2 5154.3 5155.2 5173.6 5193.3 5197.4 4937.8 5082.9 5092.9 5093.4 5145.6 4943.7 5044.6 5127.9 5156.6 5171.3 5075.6 5090.6 5091.7 5099.3 5099.9 09:37:41 INFO - PROCESS | 13529 | 09:37:41 INFO - PROCESS | 13529 | [#5] yui.html Cycles:180 Average:17600.26 Median:43721.84 stddev:24833.15 (56.8%) stddev-sans-first:24870.19 09:37:41 INFO - PROCESS | 13529 | Values: 648.0 683.0 723.3 727.2 746.4 12797.1 13671.2 13676.4 13706.5 13717.1 12098.5 12206.6 12294.6 12614.4 13148.4 762.2 780.1 783.1 784.1 785.4 622.1 764.4 787.5 797.3 800.1 831.6 834.4 834.7 834.8 835.3 643.1 835.7 835.8 836.2 837.5 587.9 604.2 605.7 605.8 606.4 13124.8 13126.9 13135.9 13139.3 13148.3 12005.6 12318.4 12491.8 12525.8 12638.2 11407.4 11751.9 11833.8 11997.6 12249.8 4087.3 4115.4 4143.3 4160.8 4176.2 54902.5 55197.2 55309.0 55474.7 56823.7 9805.5 10006.0 10148.7 10165.2 10476.9 18567.9 18579.2 18585.4 18595.4 18601.3 6898.7 6957.2 6964.2 6999.7 7004.1 3533.5 3567.4 3716.8 3795.6 3796.1 2896.0 3015.5 3018.7 3025.4 3037.2 487.0 496.1 497.1 497.8 499.4 466.4 532.8 535.3 536.1 581.0 7675.4 7808.7 7880.0 7895.2 8083.4 472.0 473.7 488.7 516.0 548.8 3862.7 3918.6 3960.1 4121.1 4122.3 57751.0 94847.5 97016.0 97641.0 97780.0 85748.1 86726.6 87701.6 87718.0 87797.0 77715.0 78431.0 79825.0 80404.2 80639.6 7415.3 7553.2 7727.2 7767.2 7998.1 43486.6 43957.1 44800.6 45276.8 46258.3 41595.0 58453.4 64782.0 65400.0 65974.7 10856.5 11261.5 11453.3 12070.9 12140.2 12442.3 12751.8 13068.8 13119.1 13545.6 11905.5 12608.4 12637.8 12939.1 12954.7 10656.1 11311.8 11504.3 12138.8 12199.9 12566.7 13110.7 13424.4 13440.3 13495.5 10545.6 10662.9 10874.5 11044.4 11129.3 10147.7 10203.3 10297.7 10418.5 10639.5 09:37:41 INFO - PROCESS | 13529 | -------- Summary: end -------- 09:37:41 INFO - PROCESS | 13529 | 09:37:42 INFO - TEST-INFO | 13529: exit 0 09:37:42 INFO - TEST-OK | dromaeo_css | took 1119620ms 09:37:42 INFO - TEST-START | kraken 09:37:42 INFO - operating with platform_type : linux_ 09:37:42 INFO - Initialising browser for kraken test... 09:37:42 INFO - TEST-INFO | started process 13717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuPLkYj/profile http://localhost:52992/getInfo.html) 09:37:46 INFO - PROCESS | 13717 | __metrics Screen width/height:1600/1200 09:37:46 INFO - PROCESS | 13717 | colorDepth:24 09:37:46 INFO - PROCESS | 13717 | Browser inner width/height: 1024/697 09:37:46 INFO - PROCESS | 13717 | __metrics 09:37:47 INFO - PROCESS | 13717 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:37:48 INFO - TEST-INFO | 13717: exit 0 09:37:48 INFO - Browser initialized. 09:37:48 INFO - Running cycle 1/1 for kraken test... 09:37:48 INFO - TEST-INFO | started process 13799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuPLkYj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:00 INFO - PROCESS | 13799 | RSS: Main: 159023104 09:38:00 INFO - PROCESS | 13799 | 09:38:03 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52992/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:04 INFO - PROCESS | 13799 | RSS: Main: 217071616 09:38:04 INFO - PROCESS | 13799 | 09:38:06 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52992/tests/kraken/driver.html?testName=audio-dft) 09:38:07 INFO - PROCESS | 13799 | RSS: Main: 204173312 09:38:07 INFO - PROCESS | 13799 | 09:38:10 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52992/tests/kraken/driver.html?testName=audio-fft) 09:38:11 INFO - PROCESS | 13799 | RSS: Main: 271740928 09:38:11 INFO - PROCESS | 13799 | 09:38:13 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52992/tests/kraken/driver.html?testName=audio-oscillator) 09:38:14 INFO - PROCESS | 13799 | RSS: Main: 182005760 09:38:14 INFO - PROCESS | 13799 | 09:38:16 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52992/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:16 INFO - PROCESS | 13799 | RSS: Main: 185470976 09:38:16 INFO - PROCESS | 13799 | 09:38:19 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52992/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:20 INFO - PROCESS | 13799 | RSS: Main: 221904896 09:38:20 INFO - PROCESS | 13799 | 09:38:24 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52992/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:24 INFO - PROCESS | 13799 | RSS: Main: 222748672 09:38:24 INFO - PROCESS | 13799 | 09:38:27 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52992/tests/kraken/driver.html?testName=json-parse-financial) 09:38:28 INFO - PROCESS | 13799 | RSS: Main: 223043584 09:38:28 INFO - PROCESS | 13799 | 09:38:29 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52992/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:30 INFO - PROCESS | 13799 | RSS: Main: 209149952 09:38:30 INFO - PROCESS | 13799 | 09:38:32 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52992/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:32 INFO - PROCESS | 13799 | RSS: Main: 213983232 09:38:32 INFO - PROCESS | 13799 | 09:38:35 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52992/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:38:35 INFO - PROCESS | 13799 | RSS: Main: 215662592 09:38:35 INFO - PROCESS | 13799 | 09:38:38 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:39 INFO - PROCESS | 13799 | RSS: Main: 225300480 09:38:39 INFO - PROCESS | 13799 | 09:38:42 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:42 INFO - PROCESS | 13799 | RSS: Main: 226394112 09:38:42 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | Cycle 1(1): loaded http://localhost:52992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52992/tests/kraken/driver.html?testName=ai-astar) 09:38:44 INFO - PROCESS | 13799 | RSS: Main: 268374016 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | __start_tp_report 09:38:44 INFO - PROCESS | 13799 | _x_x_mozilla_page_load 09:38:44 INFO - PROCESS | 13799 | _x_x_mozilla_page_load_details 09:38:44 INFO - PROCESS | 13799 | |i|pagename|runs| 09:38:44 INFO - PROCESS | 13799 | |0;ai-astar;104;114;111;112;113;112;115;113;111;115 09:38:44 INFO - PROCESS | 13799 | |1;audio-beat-detection;152;121;127;174;125;123;151;127;172;122 09:38:44 INFO - PROCESS | 13799 | |2;audio-dft;160;162;160;162;163;160;163;161;163;161 09:38:44 INFO - PROCESS | 13799 | |3;audio-fft;76;75;75;121;76;77;75;76;109;76 09:38:44 INFO - PROCESS | 13799 | |4;audio-oscillator;86;87;115;85;86;87;117;85;85;123 09:38:44 INFO - PROCESS | 13799 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;116 09:38:44 INFO - PROCESS | 13799 | |6;imaging-darkroom;146;147;147;146;146;147;146;146;146;146 09:38:44 INFO - PROCESS | 13799 | |7;imaging-desaturate;95;95;95;96;95;94;95;96;96;95 09:38:44 INFO - PROCESS | 13799 | |8;json-parse-financial;64;65;64;65;64;64;65;72;63;64 09:38:44 INFO - PROCESS | 13799 | |9;json-stringify-tinderbox;65;64;65;64;65;65;68;65;64;65 09:38:44 INFO - PROCESS | 13799 | |10;stanford-crypto-aes;79;88;79;79;79;87;77;88;79;82 09:38:44 INFO - PROCESS | 13799 | |11;stanford-crypto-ccm;140;128;134;127;131;129;131;127;165;131 09:38:44 INFO - PROCESS | 13799 | |12;stanford-crypto-pbkdf2;170;178;171;179;169;170;172;172;168;172 09:38:44 INFO - PROCESS | 13799 | |13;stanford-crypto-sha256-iterative;66;66;69;70;68;67;67;66;68;66 09:38:44 INFO - PROCESS | 13799 | __end_tp_report 09:38:44 INFO - PROCESS | 13799 | __start_cc_report 09:38:44 INFO - PROCESS | 13799 | _x_x_mozilla_cycle_collect,1957 09:38:44 INFO - PROCESS | 13799 | __end_cc_report 09:38:44 INFO - PROCESS | 13799 | __startTimestamp1467650324651__endTimestamp 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | ------- Summary: start ------- 09:38:44 INFO - PROCESS | 13799 | Number of tests: 14 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.16 (2.8%) stddev-sans-first:1.54 09:38:44 INFO - PROCESS | 13799 | Values: 104.0 114.0 111.0 112.0 113.0 112.0 115.0 113.0 111.0 115.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:139.00 stddev:21.02 (15.1%) stddev-sans-first:21.80 09:38:44 INFO - PROCESS | 13799 | Values: 152.0 121.0 127.0 174.0 125.0 123.0 151.0 127.0 172.0 122.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.27 (0.8%) stddev-sans-first:1.22 09:38:44 INFO - PROCESS | 13799 | Values: 160.0 162.0 160.0 162.0 163.0 160.0 163.0 161.0 163.0 161.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:16.80 (22.1%) stddev-sans-first:17.59 09:38:44 INFO - PROCESS | 13799 | Values: 76.0 75.0 75.0 121.0 76.0 77.0 75.0 76.0 109.0 76.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:85.50 stddev:15.83 (18.5%) stddev-sans-first:16.40 09:38:44 INFO - PROCESS | 13799 | Values: 86.0 87.0 115.0 85.0 86.0 87.0 117.0 85.0 85.0 123.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:38:44 INFO - PROCESS | 13799 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:38:44 INFO - PROCESS | 13799 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:38:44 INFO - PROCESS | 13799 | Values: 95.0 95.0 95.0 96.0 95.0 94.0 95.0 96.0 96.0 95.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.50 stddev:2.54 (3.9%) stddev-sans-first:2.67 09:38:44 INFO - PROCESS | 13799 | Values: 64.0 65.0 64.0 65.0 64.0 64.0 65.0 72.0 63.0 64.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.15 (1.8%) stddev-sans-first:1.22 09:38:44 INFO - PROCESS | 13799 | Values: 65.0 64.0 65.0 64.0 65.0 65.0 68.0 65.0 64.0 65.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:80.50 stddev:4.30 (5.3%) stddev-sans-first:4.44 09:38:44 INFO - PROCESS | 13799 | Values: 79.0 88.0 79.0 79.0 79.0 87.0 77.0 88.0 79.0 82.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:131.00 stddev:11.46 (8.7%) stddev-sans-first:11.97 09:38:44 INFO - PROCESS | 13799 | Values: 140.0 128.0 134.0 127.0 131.0 129.0 131.0 127.0 165.0 131.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.00 stddev:3.63 (2.1%) stddev-sans-first:3.77 09:38:44 INFO - PROCESS | 13799 | Values: 170.0 178.0 171.0 179.0 169.0 170.0 172.0 172.0 168.0 172.0 09:38:44 INFO - PROCESS | 13799 | 09:38:44 INFO - PROCESS | 13799 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.42 (2.1%) stddev-sans-first:1.42 09:38:44 INFO - PROCESS | 13799 | Values: 66.0 66.0 69.0 70.0 68.0 67.0 67.0 66.0 68.0 66.0 09:38:44 INFO - PROCESS | 13799 | -------- Summary: end -------- 09:38:44 INFO - PROCESS | 13799 | 09:38:45 INFO - TEST-INFO | 13799: exit 0 09:38:45 INFO - TEST-OK | kraken | took 63175ms 09:38:45 INFO - SUITE-END | took 1182s 09:38:45 INFO - Completed test suite (00:19:42) 09:38:45 INFO - javascript benchmark 09:38:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2614.3725505878588, 2633.6181253718223, 2658.960115598265, 2659.654244948157, 2676.0366268143466, 4668.136394766971, 4704.343042359905, 4779.235322348425, 4783.35424717663, 4819.903601927964, 4670.416197975253, 4718.528147185289, 4731.834385796497, 4743.644226682995, 4744.739039352834, 4150.43969064177, 4290.678199135062, 4398.120375924812, 4432.20220360335, 4483.193025255453, 4412.955870441303, 4440.4893437254805, 4449.310356894686, 4457.955420445803, 4491.865244042684, 4242.745435273878, 4293.978530107361, 4322.589354011364, 4335.1329734053315, 4373.365861950031, 4351.369051487517, 4360.760158191299, 4413.29387298034, 4422.181896349153, 4423.0711550574415, 4386.356644536413, 4399.340098985178, 4407.911841763179, 4447.132809102226, 4449.9555004450185, 4645.117427688729, 4731.313959475857, 4815.301781241736, 4822.300766388854, 4837.7339246341435, 5113.642045056848, 5167.586593072545, 5178.249153872705, 5179.870503237412, 5180.041692286939, 5024.547790698854, 5186.0665080285535, 5227.738613069331, 5228.085085110129, 5229.1633338666015, 4735.337052812609, 4765.11845308619, 4772.093302272557, 4804.447488538863, 4824.95175048245, 5297.205419187076, 5306.52241298285, 5309.8938021239355, 5310.575153987672, 5313.707746073926, 4915.87710307238, 4978.303037574742, 5051.6716413433005, 5076.289319495274, 5128.307678463434, 5086.593072554261, 5104.897902041938, 5123.666961647481, 5123.820666276662, 5172.612054095883, 5072.898542029213, 5080.568151707146, 5096.643234973516, 5101.183810590362, 5145.536901678867, 4934.0, 4999.775010124553, 5009.0, 5088.465711100355, 5091.261767043832, 4378.846740364072, 4386.649068074546, 4406.801693923781, 4441.444819397575, 4447.73313601185, 3802.885913422602, 3829.483019792348, 3836.1368692044625, 3856.82644281008, 3874.9225015499533, 4352.630026447788, 4352.847650332224, 4380.2772542530765, 4401.779911004437, 4408.845690400821, 5084.949150508522, 5110.361204849394, 5111.284420181178, 5143.331366922276, 5156.020356132323, 4397.428334316518, 4406.911861762746, 4410.16206920684, 4449.310356894686, 4456.108778244364, 4533.274676051882, 4554.726716397026, 4600.470945841204, 4613.169629466661, 4619.122366750306, 4765.785539650655, 4783.808647654194, 4790.904181916412, 4799.0, 4841.927371089366, 5103.87240318995, 5140.691558506502, 5141.768620412166, 5145.099607568735, 5150.0987327216835, 4628.560286772751, 4658.0, 4670.696404733681, 4806.519348065165, 4856.465788763304, 4934.432540257916, 4959.454460009469, 4966.130927087673, 5012.498750124958, 5062.139436295765, 5130.102232109441, 5153.149730294609, 5189.636725429184, 5199.11615025439, 5200.479952004769, 4987.276844857548, 4992.475790041994, 5000.224965130411, 5002.549770520671, 5045.419776725724, 4858.3441235432765, 4904.803807847647, 4998.275250088789, 5008.098542262282, 5013.24801279811, 4848.95151048485, 4917.582005529427, 4924.8768780780765, 4966.130927087817, 4974.154393753143, 5002.974985125051, 5003.874903127451, 5004.224345226496, 5008.348914641073, 5050.3434553507805, 4732.290156476556, 4839.935214252859, 4841.491643377394, 4916.606671466346, 4951.430585482715], "value": 4690.990475821773, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9164921086442, 581.7033313010363, 582.1355287398213, 586.3374386942754, 588.2617315269338, 27330.86334568327, 29854.701452985464, 29913.1026069218, 40492.39261411074, 41717.582824171746, 40983.38524922128, 41333.58666413335, 41524.16951660965, 41526.37710434338, 41620.79189604055, 7816.531008139501, 7946.364290856746, 7947.761567152995, 7957.283844453998, 7960.800979975518, 7607.885881711751, 7768.5338879667115, 7791.220877912192, 7919.049714034324, 7969.681212751512, 10140.746481337988, 10454.320469169517, 10458.372497650165, 10747.247692661516, 10760.73098172544, 10120.595176192943, 10207.438590877498, 10209.744756381077, 10209.948950255239, 10210.693679189637, 7404.074490688664, 9854.21166306701, 10089.646862359856, 10188.74528136795, 10242.743931401774, 38219.23561528782, 38555.807220963994, 38653.806730966164, 38679.41980870289, 38703.0, 2932.384199318146, 2956.127942257039, 3063.4638938185726, 3098.3803239351996, 3304.80171189727, 29106.272343191376, 29282.853585731937, 29285.41429171426, 29402.117936461942, 29582.0, 3459.60214575322, 3490.458978858281, 3504.2816222674546, 3507.8596856125723, 3533.205028868484, 259019.0, 259581.0, 259769.0, 260653.0, 261356.0, 52170.21744673833, 52821.471785281654, 52869.2069618956, 52900.206496902574, 52925.2061219082, 54683.179752303746, 54701.0, 54748.45251547434, 54758.17862732062, 54781.5218478157, 14795.630109247355, 15094.773578396333, 15134.848651513565, 15142.242887855564, 15218.315175816893, 11831.349275789742, 11851.88148118525, 11882.75231100722, 11907.523699052113, 11922.046236301248, 13306.933465332804, 14573.781393279109, 14681.706365872622, 14786.408543658134, 15404.691906162037, 5708.343540492813, 5805.158252053428, 5870.823875283663, 5890.293164820249, 5941.732622032019, 795.6578671171336, 863.926566241864, 881.0836729801064, 908.404994728454, 924.3390975452584, 28484.287892802844, 28530.714692852805, 28566.857165714453, 28617.427651446855, 29088.27279318034, 972.4505654305295, 974.6101559376165, 978.9476312963593, 991.6975322526698, 1027.198784947742, 15321.463748768963, 15964.680706385807, 16508.6698266034, 16739.91630041842, 16775.748363774554, 383035.0, 386646.0, 387510.0, 387715.0, 389009.0, 50514.494855051715, 50756.49243507592, 50857.0, 50925.745371273646, 51027.0, 1023.5905637744813, 1096.7093720164162, 1148.3741360958131, 1171.5957994491887, 1191.582945968904, 26227.868860655573, 27786.305342366602, 28646.140615781558, 29447.411051778417, 29611.259718507208, 48086.27870582014, 48250.75874620605, 48516.5148348512, 48712.26931595958, 48730.26904596505, 340596.0, 342094.0, 342620.0, 342713.0, 344140.0, 21883.562328753655, 24125.552466852045, 24597.139100131408, 25135.74864251407, 25271.115510957763, 41188.116831821484, 41659.583404166784, 42420.151596968506, 42448.36327455029, 42917.570824292605, 35357.469637954935, 36092.27815443729, 36747.816260918524, 37002.814985924895, 37373.81313093417, 36310.27379452449, 36809.0, 37116.443253350684, 37219.62780372162, 37739.0, 35628.28743425169, 35896.10259743423, 37494.625053750206, 37846.43230351492, 39848.402273966494, 30819.845900770353, 33200.0, 33446.832765836014, 33624.327513449105, 33930.66069339275, 25061.74938250667, 25783.226503204933, 25927.74072259253, 25941.35146621274, 25982.380086701553], "value": 17923.399287982353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.0144788799808, 355.67455777963147, 369.8705453091418, 375.65064490024275, 391.6357787257851, 13033.41349639266, 16382.098984555845, 16610.916945415254, 17461.563460913483, 18407.17167727452, 17087.31650733972, 17515.2118154683, 17829.019403932813, 17842.82157178428, 18160.81839181608, 4961.452561418585, 5092.592592592584, 5234.450382709818, 5249.1338929076655, 5249.265102885599, 3654.104744337641, 4886.926696099544, 5154.92267615986, 5801.622894511843, 6086.7565297388055, 6146.047362658773, 6173.043178307369, 6187.195664563623, 6188.164597779287, 6188.319284878659, 6000.069989151667, 6159.630422174684, 6204.47261982732, 6224.595401298901, 6230.532710046765, 3356.7314614831, 3527.400341941876, 3530.0468873404293, 5440.619156659035, 5446.700431476267, 18880.43358699241, 20889.37331880046, 21008.684869726967, 22030.779692203032, 22259.109635614557, 1881.8870867747842, 1884.3122260375, 1889.3670620342202, 2230.520438105799, 2555.1440267510407, 13224.471021159143, 13334.399952002183, 13471.12437691547, 13622.114562553403, 13837.654058648513, 1681.6132289573466, 1733.4886208568503, 1799.9280028798833, 1824.2155872974615, 1832.0564909071707, 70744.6462767688, 71511.28488715098, 72076.6396168021, 73004.63497682531, 73369.0, 8736.650533978569, 8880.245179159843, 9216.907830921738, 9252.95373523128, 10124.291299608956, 13269.07116501855, 13778.0, 13794.448222071005, 13827.723445531034, 13855.653608659864, 7390.7413240536325, 7396.149442814038, 7490.288422599844, 7529.623518824037, 7630.961845190738, 7013.403860671798, 7228.060352154186, 7321.890171647429, 7350.705971761176, 7433.4053275737815, 6332.651704156316, 6360.681965901686, 6380.936190638127, 6462.642845002602, 6484.773032943919, 1734.2282684205659, 1773.3881810775263, 1776.9200385982404, 1790.0756686561738, 1817.681905666503, 798.2017982017982, 816.3550794872103, 836.6323305046703, 927.8190752803139, 953.1469334945324, 17551.385701500643, 17889.642207155783, 18197.818021819876, 18245.7263141053, 18317.17572709231, 855.7561095087995, 878.9824203516022, 884.4516399832145, 894.8478758611052, 962.7063745557672, 9804.411735295906, 10175.542100605491, 10367.118794902517, 10392.272540922062, 10500.00249976251, 382651.0, 399852.0, 406960.0, 407938.0, 408699.0, 45125.77437112859, 72644.0, 74595.0, 74721.0, 74906.30754950162, 911.6080085563138, 918.0589895357313, 918.0956757593765, 920.1120918313993, 926.9026752191057, 16010.519684409486, 16157.919210404343, 16201.351945922032, 16267.349306027627, 16294.185290735653, 28022.71977280201, 33298.0, 34422.31155376929, 37400.62599373971, 37470.0, 46594.534054659016, 46700.299495506915, 46822.29766553437, 47136.0, 47348.76325618487, 7720.652570634223, 7887.171846955987, 7929.960350198212, 7930.841383172419, 8084.959575202086, 11696.70758231051, 12061.216020958609, 12069.939650301692, 12476.812847807108, 12671.556495522613, 9958.452285124387, 10381.221408394249, 10456.05895469381, 10468.0, 11123.888761112285, 10496.317739346918, 10672.83990740155, 10841.241113122005, 11065.170112241452, 11111.777764444827, 10884.782304354027, 10913.83629245546, 11073.0, 11119.166062545502, 11171.05046071093, 6653.434458071119, 6937.7571784987285, 7140.143182818095, 7406.851862962818, 8171.673133074848, 9047.68333108338, 10363.896361036293, 10418.062374386342, 10471.371717696962, 10490.108340791117], "value": 8445.608934433109, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.756442622541, 1428.31440908364, 1454.4763885001398, 1694.4747128390193, 1720.9999999999993, 7540.886886696704, 7986.241307075833, 8070.354371650268, 8084.555349455785, 8089.716859909911, 6707.496937729666, 6941.583504989704, 6946.097007389045, 7116.039334689828, 7879.251471110249, 2143.699882016515, 2224.744154422246, 2239.652853807654, 2251.6284813005836, 2256.255435706213, 2237.8097861681777, 2238.6418173092306, 2259.48031952651, 2262.2082271205113, 2277.339571524256, 1865.4590168851016, 2155.137944822068, 2240.8543444676125, 2244.955100897981, 2251.34710933829, 2161.502854343502, 2194.967075493869, 2197.3407977606653, 2197.7252843394576, 2199.285232299509, 2169.4142581502906, 2175.5213852952484, 2221.0116498158327, 2226.365485836529, 2232.352617740853, 7966.800829979297, 8021.5989200540325, 8034.718784842503, 8037.799055023671, 8043.678252869879, 4515.977420112911, 4608.055348653518, 4648.302754586805, 4654.208784506642, 4657.697249678794, 2861.141657502741, 2861.4992376334267, 2910.3742695320607, 2961.614990051301, 2975.538791487323, 937.6436953957452, 963.2534785541261, 963.6675347005272, 971.4365667912593, 1626.0, 10237.129843963272, 10496.632617858415, 10509.527071281811, 10615.628453004108, 10620.415877126756, 3912.178442527101, 4051.6353528182603, 4125.381192821101, 4130.256553820341, 4132.876013719593, 8415.0, 8448.281896038905, 8462.746117616482, 8464.32285417165, 8470.618822153017, 4546.1135078659345, 4567.771611419482, 4571.291449825282, 4571.679982401267, 4577.5193604671695, 3728.4034554471154, 3792.943105853414, 4266.2960611499375, 4275.337322714922, 4284.357346398066, 3388.423967925459, 3507.2459421224557, 3518.876839310663, 3520.8063556504126, 3528.1356067763563, 1063.473580577619, 1065.4832406282947, 1081.1512962324537, 1102.0962810495316, 1104.9337039777638, 844.3414136973171, 861.3238607692931, 861.573521107056, 885.6191837509804, 897.1701176411793, 5269.841904742864, 5373.7581808818695, 5389.946100538945, 5692.089265717548, 5788.88422231553, 807.2129673568224, 827.1604321613567, 852.4501696405783, 893.3657103456619, 926.3515539122641, 3584.1577229351083, 3710.4434334849448, 3725.776453412804, 3753.3886142560973, 3767.7927713975446, 9465.242780577537, 9718.514074296398, 9832.360896541702, 9895.158911492459, 9920.652777152765, 9801.019898010141, 9811.0, 9817.312788104908, 9833.950830245803, 9866.605335786631, 7305.305995930378, 7417.740379086598, 7420.332170104716, 7422.331990120915, 7441.962790186123, 5327.520523152934, 5362.410134885237, 5416.485433883775, 5553.111502159635, 5650.85872853182, 8711.651533938824, 9055.592498337459, 9095.226905713089, 9185.586648600696, 9350.579223935076, 7957.801054973672, 8629.266512346521, 9097.59060842277, 9310.255179585753, 9415.05849415053, 7191.316824901626, 7500.812479688051, 7535.54786712799, 7538.811529711801, 7669.69321227167, 7324.121105467378, 7620.237976202336, 7639.388848892187, 7645.694172233271, 7651.655675494728, 6895.6552172392185, 6934.618595977068, 7008.964955175192, 7029.648517573998, 7171.318724721144, 6856.280090590416, 6904.551204171713, 6934.757283495053, 6963.373296403348, 7021.227664956953, 6454.870902582016, 6489.772857949949, 6516.348365163635, 6519.902201467076, 6536.6731663415685, 4557.819739923325, 4624.907501850012, 4752.477227504903, 4808.374911261653, 4810.63920205993, 4791.784369703441, 4804.711717296974, 4809.759512024455, 4826.0, 4904.313396124617], "value": 4196.632442372352, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.5281085101817, 309.7816039692017, 312.62172770947154, 313.99372012559763, 316.61847473794074, 4837.758112094394, 4879.194932836087, 4879.9756001219985, 4886.43805962314, 4903.725031491811, 4784.091022705684, 4805.375301210846, 4852.5147485251455, 4856.878578035551, 4862.173430516812, 3672.7979961102196, 3768.56927281903, 3803.82882770276, 3853.5953724858905, 3879.5538513071074, 3829.5021647185968, 3835.6356146166067, 3878.1661942682317, 3885.358915778893, 3914.1193231522966, 3804.410316400962, 3832.156925476391, 3832.482614846988, 3837.9424308635394, 3852.845886164564, 3658.579263384705, 3715.1640880801874, 3802.714796390254, 3823.388257878754, 3850.4416859555486, 3430.5711786026745, 3436.9828150859084, 3440.82795860206, 3443.3974054540354, 3443.483477478373, 4777.140114779339, 4777.355057067286, 4777.474477807438, 4779.115863565252, 4789.473157952622, 4139.710220284551, 4295.248331541968, 4332.566743325642, 4408.096340250241, 4416.3596278539435, 5100.974495127501, 5103.4896510349035, 5105.463926287761, 5120.871978200537, 5133.768980395891, 3657.305112028706, 3661.7802931824176, 3668.486411902336, 3669.6513831185994, 3673.210259794157, 5035.194368900959, 5340.599455040888, 5360.785568577252, 5364.202991997686, 5386.841829006743, 3682.1531047858607, 3689.3912504436466, 3694.8569829498824, 3695.630436956337, 3712.276106159273, 3737.588865224823, 3763.2097259575794, 3767.095896984759, 3771.453139294787, 3773.6226377362045, 4297.957020429818, 4310.374995625617, 4321.611055005064, 4325.589069038437, 4329.653627709776, 4968.826091086795, 5033.84898453047, 5080.872978175576, 5110.616703747234, 5128.589712822965, 1280.8527019392702, 1300.0639539531521, 1300.219868079145, 1300.8048792680984, 1302.0625149892253, 827.2967977219436, 827.6192951242496, 847.9788005299794, 855.422589751915, 873.0527377795037, 4457.353683715908, 4485.641148708096, 4488.259437192826, 4494.977525112354, 4501.977490112528, 5170.482951704875, 5172.19830926207, 5202.24567437727, 5230.927659829726, 5264.763085661154, 4326.394304797331, 4417.889552761207, 4420.84527041552, 4454.22051141049, 4458.77706114693, 2785.8607069646437, 2791.6231308773054, 2798.188525327673, 2804.3314228034287, 2810.3114736889593, 4930.11257973561, 4930.767308172957, 4943.703377797272, 4950.950490495121, 4964.329815474937, 5129.256257842592, 5391.757370918318, 5393.894251678396, 5397.217403476474, 5399.163129714901, 4920.852374428701, 4954.727489988085, 4959.2065269557415, 4962.900741985212, 4967.602591792648, 5266.78932842682, 5272.0, 5277.0, 5277.973610131925, 5283.89432211346, 4914.34625302347, 5192.597998540448, 5204.193350030751, 5204.7918083276245, 5212.0, 4955.776990035385, 4962.578180854668, 4970.210724139235, 4970.552650261494, 4977.825776097964, 3765.1340191755503, 3795.544534655859, 3807.8857634271017, 3811.485449464287, 3818.980905095457, 5168.250603662523, 5291.603129765206, 5316.989771943473, 5371.958655710805, 5382.515573598395, 5138.7923837897315, 5140.948590514047, 5145.202493613496, 5153.561947234377, 5156.20078887773, 5154.252633368215, 5155.175171972466, 5173.63784535094, 5193.298904647975, 5197.402298735694, 4937.8271760488215, 5082.872928176826, 5092.879566495365, 5093.388793344822, 5145.610685115073, 4943.728094954812, 5044.596432285482, 5127.92308115386, 5156.56169225605, 5171.250168725439, 5075.609597698039, 5090.592752579711, 5091.694498330112, 5099.337086178922, 5099.92350114756], "value": 3860.6281332833505, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.9902801457978, 682.9795106146818, 723.334532230348, 727.2291371146586, 746.4215233194274, 12797.104202705814, 13671.179729216254, 13676.384562694679, 13706.520271790489, 13717.108387954777, 12098.516059357615, 12206.572769953053, 12294.63116106516, 12614.36928153591, 13148.408321625526, 762.1616222155626, 780.0717146595562, 783.1385475976409, 784.1296161260996, 785.4305628419407, 622.1476577089394, 764.3579393309619, 787.4684587903142, 797.3222760653456, 800.0599295827409, 831.55096248026, 834.4284165346727, 834.7328854766478, 834.7620928035511, 835.2566216067704, 643.1414062226933, 835.715856608756, 835.7868743470407, 836.1805430677908, 837.5016864965366, 587.8794847056344, 604.1511676095093, 605.6699098991061, 605.7819185093363, 606.3784620763709, 13124.803127953088, 13126.934365328209, 13135.934320328433, 13139.343032848416, 13148.276844773534, 12005.57980470688, 12318.384080795924, 12491.75016499674, 12525.812112818225, 12638.178518396275, 11407.372594507298, 11751.882481175164, 11833.763324733458, 11997.580084697081, 12249.755004899942, 4087.3255912774357, 4115.36211887158, 4143.316352801784, 4160.750354978711, 4176.206520761046, 54902.45097549013, 55197.1720424194, 55309.0, 55474.72262638661, 56823.71588142033, 9805.509724513746, 10006.0, 10148.746281342877, 10165.186785057178, 10476.895231047745, 18567.90716046411, 18579.163937622838, 18585.44243672692, 18595.44213673592, 18601.348952786586, 6898.724051037902, 6957.234704182536, 6964.233934267227, 6999.650017499104, 7004.124484439445, 3533.4699795030438, 3567.4113771227458, 3716.758410703296, 3795.6204379562373, 3796.145867179918, 2896.0, 3015.487367147546, 3018.683038280949, 3025.3797971415806, 3037.2255074955747, 487.04539103357814, 496.1317694035438, 497.07295893159, 497.8182963218399, 499.3757802746567, 466.37272867992493, 532.7895481284871, 535.3014316317243, 536.085973415326, 581.0325807530498, 7675.424343174284, 7808.726694565663, 7880.0, 7895.249951254622, 8083.436801589272, 471.9811207551728, 473.69210013491505, 488.7336401661103, 515.9886622220415, 548.7914592454921, 3862.671672907778, 3918.6081391861157, 3960.089179488734, 4121.093359460914, 4122.3404255319, 57751.0, 94847.52576237213, 97016.0, 97641.02358976462, 97780.0, 85748.14251857526, 86726.56636716903, 87701.56149219214, 87718.0, 87797.0, 77715.0, 78431.0, 79825.0, 80404.19595804084, 80639.59680201561, 7415.3326200642205, 7553.164998256798, 7727.227277272228, 7767.155258147253, 7998.080220774686, 43486.56513434825, 43957.12085758203, 44800.55199448094, 45276.77361613171, 46258.30612540747, 41595.0, 58453.4154658465, 64782.0, 65400.0, 65974.67012664906, 10856.45717714127, 11261.549538018715, 11453.312801231952, 12070.939645301718, 12140.15018948665, 12442.253464792142, 12751.808722868978, 13068.80396794068, 13119.147255428366, 13545.59363219105, 11905.464254108412, 12608.432620531914, 12637.810432843698, 12939.094263401472, 12954.740905182032, 10656.10432466284, 11311.751636520805, 11504.309741415542, 12138.817917731065, 12199.87800122023, 12566.748665026831, 13110.672233194246, 13424.39590218462, 13440.327983600977, 13495.527656531975, 10545.630902918361, 10662.946685266834, 10874.456277186267, 11044.447777611247, 11129.276597021168, 10147.695569132939, 10203.336783109075, 10297.691069267934, 10418.531166097393, 10639.521221544894], "value": 6592.028127951178, "unit": "score"}], "name": "dromaeo_css", "value": 6506.147495694575, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 111.0, 112.0, 113.0, 112.0, 115.0, 113.0, 111.0, 115.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 127.0, 174.0, 125.0, 123.0, 151.0, 127.0, 172.0, 122.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 163.0, 160.0, 163.0, 161.0, 163.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 121.0, 76.0, 77.0, 75.0, 76.0, 109.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 115.0, 85.0, 86.0, 87.0, 117.0, 85.0, 85.0, 123.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 96.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 72.0, 63.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 68.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 88.0, 79.0, 79.0, 79.0, 87.0, 77.0, 88.0, 79.0, 82.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 128.0, 134.0, 127.0, 131.0, 129.0, 131.0, 127.0, 165.0, 131.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 178.0, 171.0, 179.0, 169.0, 170.0, 172.0, 172.0, 168.0, 172.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 69.0, 70.0, 68.0, 67.0, 67.0, 66.0, 68.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1535.8, "alertThreshold": 2.0}]} 09:38:45 INFO - Return code: 0 09:38:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:38:45 INFO - # TBPL SUCCESS # 09:38:45 INFO - Running post-action listener: _resource_record_post_action 09:38:45 INFO - ##### 09:38:45 INFO - ##### Finished run-tests step (success) 09:38:45 INFO - ##### 09:38:45 INFO - Running post-run listener: _resource_record_post_run 09:38:46 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534876160; Read time: 4; Write time: 396024 09:38:46 INFO - TinderboxPrint: CPU usage
12.9% 09:38:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 09:38:46 INFO - TinderboxPrint: I/O write bytes / time
534,876,160 / 396,024 09:38:46 INFO - TinderboxPrint: CPU idle
8,330.5 (87.0%) 09:38:46 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 09:38:46 INFO - TinderboxPrint: Swap in / out
0 / 0 09:38:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246452224; Read time: 0; Write time: 227244 09:38:46 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288423936; Read time: 0; Write time: 168780 09:38:46 INFO - Running post-run listener: _upload_blobber_files 09:38:46 INFO - Blob upload gear active. 09:38:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:38:46 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 09:38:46 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'] 09:38:46 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 09:38:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:38:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:50 INFO - (blobuploader) - INFO - Done attempting. 09:38:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:38:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:51 INFO - (blobuploader) - INFO - Done attempting. 09:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:52 INFO - (blobuploader) - INFO - Done attempting. 09:38:52 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:52 INFO - Return code: 0 09:38:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:38:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edee5dd16869e48766f9f9b6910f3d46675ad099c26b2bee3609e1bf3eab6c583a588c961b45ef444742a5bc4717213ba9813cad8aa4d5c6829c5fe3b28765af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/441229815ae20007f749b53710fa1266910b6b88eb0963601977b912d91be4d2259b43eaa3156fad41716fcceb0de78d3e2242705768834405edf1b198e5b111", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90770aa52caa1cf5a152bc1daf7273b9c4df23cd761a695b6fce2a78c2788081ccc03e1b795deb6c5a7758e6f111edd4a2ad1dccc2355ae25b0a9b1a4d314856"} 09:38:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:38:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:38:52 INFO - Contents: 09:38:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edee5dd16869e48766f9f9b6910f3d46675ad099c26b2bee3609e1bf3eab6c583a588c961b45ef444742a5bc4717213ba9813cad8aa4d5c6829c5fe3b28765af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/441229815ae20007f749b53710fa1266910b6b88eb0963601977b912d91be4d2259b43eaa3156fad41716fcceb0de78d3e2242705768834405edf1b198e5b111", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90770aa52caa1cf5a152bc1daf7273b9c4df23cd761a695b6fce2a78c2788081ccc03e1b795deb6c5a7758e6f111edd4a2ad1dccc2355ae25b0a9b1a4d314856"} 09:38:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:52 INFO - Copying logs to upload dir... 09:38:52 INFO - mkdir: /builds/slave/test/build/upload/logs 09:38:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.779022 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-04 09:38:52.380872) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 09:38:52.384691) ========= 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=523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746 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/edee5dd16869e48766f9f9b6910f3d46675ad099c26b2bee3609e1bf3eab6c583a588c961b45ef444742a5bc4717213ba9813cad8aa4d5c6829c5fe3b28765af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/441229815ae20007f749b53710fa1266910b6b88eb0963601977b912d91be4d2259b43eaa3156fad41716fcceb0de78d3e2242705768834405edf1b198e5b111", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90770aa52caa1cf5a152bc1daf7273b9c4df23cd761a695b6fce2a78c2788081ccc03e1b795deb6c5a7758e6f111edd4a2ad1dccc2355ae25b0a9b1a4d314856"} build_url:https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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/edee5dd16869e48766f9f9b6910f3d46675ad099c26b2bee3609e1bf3eab6c583a588c961b45ef444742a5bc4717213ba9813cad8aa4d5c6829c5fe3b28765af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/441229815ae20007f749b53710fa1266910b6b88eb0963601977b912d91be4d2259b43eaa3156fad41716fcceb0de78d3e2242705768834405edf1b198e5b111", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90770aa52caa1cf5a152bc1daf7273b9c4df23cd761a695b6fce2a78c2788081ccc03e1b795deb6c5a7758e6f111edd4a2ad1dccc2355ae25b0a9b1a4d314856"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 09:38:52.413764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:38:52.414552) ========= 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=523ca41ca1e0623de333ad52000001bf-1467649075.370962-1782592746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:38:52.496294) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 09:38:52.496673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 09:38:52.496988) ========= ========= Total master_lag: 0.17 =========