builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1468084637.88 results: success (0) buildid: 20160709085426 builduid: 8bf60173bcf44f6eb4526f2685146476 revision: 679118259e91f40d4a8f968f03ec4cff066cdb5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:17.877959) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:17.878574) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:17.878905) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:17.905805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:17.906298) ========= 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=6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 10:17:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-07-09 10:17:19 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:18.132473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:18.132787) ========= 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=6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018294 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:18.182954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-09 10:17:18.183303) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 679118259e91f40d4a8f968f03ec4cff066cdb5b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 679118259e91f40d4a8f968f03ec4cff066cdb5b --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=6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 10:17:19,183 truncating revision to first 12 chars 2016-07-09 10:17:19,183 Setting DEBUG logging. 2016-07-09 10:17:19,183 attempt 1/10 2016-07-09 10:17:19,183 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/679118259e91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 10:17:20,289 unpacking tar archive at: mozilla-central-679118259e91/testing/mozharness/ program finished with exit code 0 elapsedTime=1.450379 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-09 10:17:19.652855) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:19.653130) ========= script_repo_revision: 679118259e91f40d4a8f968f03ec4cff066cdb5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:19.653531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:19.653814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 10:17:19.664514) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-09 10:17:19.664776) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:17:20 INFO - MultiFileLogger online at 20160709 10:17:20 in /builds/slave/test 10:17:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:17:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:17:20 INFO - {'append_to_log': False, 10:17:20 INFO - 'base_work_dir': '/builds/slave/test', 10:17:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:17:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:17:20 INFO - 'branch': 'Firefox-Non-PGO', 10:17:20 INFO - 'buildbot_json_path': 'buildprops.json', 10:17:20 INFO - 'config_files': ('talos/linux_config.py',), 10:17:20 INFO - 'default_actions': ('clobber', 10:17:20 INFO - 'read-buildbot-config', 10:17:20 INFO - 'download-and-extract', 10:17:20 INFO - 'populate-webroot', 10:17:20 INFO - 'create-virtualenv', 10:17:20 INFO - 'install', 10:17:20 INFO - 'run-tests'), 10:17:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:17:20 INFO - 'download_minidump_stackwalk': True, 10:17:20 INFO - 'download_symbols': 'ondemand', 10:17:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:17:20 INFO - 'tooltool.py': '/tools/tooltool.py', 10:17:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:17:20 INFO - '/tools/misc-python/virtualenv.py')}, 10:17:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:17:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:17:20 INFO - 'installer_path': 'installer.exe', 10:17:20 INFO - 'log_level': 'info', 10:17:20 INFO - 'log_name': 'talos', 10:17:20 INFO - 'log_to_console': True, 10:17:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:17:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:17:20 INFO - 'opt_config_files': (), 10:17:20 INFO - 'pip_index': False, 10:17:20 INFO - 'sps_profile': False, 10:17:20 INFO - 'sps_profile_interval': 0, 10:17:20 INFO - 'suite': 'dromaeojs', 10:17:20 INFO - 'system_bits': '32', 10:17:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:17:20 INFO - 'title': 'talos-linux64-ix-050', 10:17:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:17:20 INFO - 'use_talos_json': True, 10:17:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:17:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:17:20 INFO - 'work_dir': 'build'} 10:17:20 INFO - ##### 10:17:20 INFO - ##### Running clobber step. 10:17:20 INFO - ##### 10:17:20 INFO - Running pre-action listener: _resource_record_pre_action 10:17:20 INFO - Running main action method: clobber 10:17:20 INFO - rmtree: /builds/slave/test/build 10:17:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:17:21 INFO - Running post-action listener: _resource_record_post_action 10:17:21 INFO - ##### 10:17:21 INFO - ##### Finished clobber step (success) 10:17:21 INFO - ##### 10:17:21 INFO - ##### 10:17:21 INFO - ##### Running read-buildbot-config step. 10:17:21 INFO - ##### 10:17:21 INFO - Running pre-action listener: _resource_record_pre_action 10:17:21 INFO - Running main action method: read_buildbot_config 10:17:21 INFO - Using buildbot properties: 10:17:21 INFO - { 10:17:21 INFO - "project": "", 10:17:21 INFO - "product": "firefox", 10:17:21 INFO - "script_repo_revision": "production", 10:17:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:17:21 INFO - "repository": "", 10:17:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:17:21 INFO - "buildid": "20160709085426", 10:17:21 INFO - "pgo_build": "False", 10:17:21 INFO - "basedir": "/builds/slave/test", 10:17:21 INFO - "buildnumber": 549, 10:17:21 INFO - "slavename": "talos-linux64-ix-050", 10:17:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:17:21 INFO - "platform": "ubuntu64_hw", 10:17:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:17:21 INFO - "branch": "mozilla-central", 10:17:21 INFO - "repo_path": "mozilla-central", 10:17:21 INFO - "revision": "679118259e91f40d4a8f968f03ec4cff066cdb5b", 10:17:21 INFO - "stage_platform": "linux64", 10:17:21 INFO - "builduid": "8bf60173bcf44f6eb4526f2685146476", 10:17:21 INFO - "slavebuilddir": "test" 10:17:21 INFO - } 10:17:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:17:21 INFO - Running post-action listener: _resource_record_post_action 10:17:21 INFO - ##### 10:17:21 INFO - ##### Finished read-buildbot-config step (success) 10:17:21 INFO - ##### 10:17:21 INFO - ##### 10:17:21 INFO - ##### Running download-and-extract step. 10:17:21 INFO - ##### 10:17:21 INFO - Running pre-action listener: _resource_record_pre_action 10:17:21 INFO - Running main action method: download_and_extract 10:17:21 INFO - mkdir: /builds/slave/test/build/tests 10:17: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')]} 10:17:21 INFO - https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:17:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:17:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:17:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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 10:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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 10:17:24 INFO - Downloaded 1361 bytes. 10:17:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:17:24 INFO - Using the following test package requirements: 10:17:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:17:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:17:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:17:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:24 INFO - u'jsshell-linux-x86_64.zip'], 10:17:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:17:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:17:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:17:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:17:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:17:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:17:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:24 INFO - https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:17:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:17:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:17:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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 10:17:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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 10:17:25 INFO - Downloaded 22735220 bytes. 10:17:25 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'] 10:17:25 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 10:17:26 INFO - Return code: 0 10:17:26 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 10:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:17:26 INFO - https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:17:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:17:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:17:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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 10:17:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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 10:17:28 INFO - Downloaded 22735220 bytes. 10:17:28 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'] 10:17:28 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 10:17:29 INFO - Return code: 0 10:17:29 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')]} 10:17:29 INFO - https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:17:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:17:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:17:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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 10:17:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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 10:17:30 INFO - Downloaded 14403333 bytes. 10:17:30 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'] 10:17:30 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 10:17:31 INFO - Return code: 0 10:17:31 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')]} 10:17:31 INFO - https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:17:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:17:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:17:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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 10:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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 10:17:34 INFO - Downloaded 56660532 bytes. 10:17:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:17:34 INFO - mkdir: /builds/slave/test/properties 10:17:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:17:34 INFO - Writing to file /builds/slave/test/properties/build_url 10:17:34 INFO - Contents: 10:17:34 INFO - build_url:https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:17:35 INFO - Running post-action listener: _resource_record_post_action 10:17:35 INFO - Running post-action listener: set_extra_try_arguments 10:17:35 INFO - ##### 10:17:35 INFO - ##### Finished download-and-extract step (success) 10:17:35 INFO - ##### 10:17:35 INFO - ##### 10:17:35 INFO - ##### Running populate-webroot step. 10:17:35 INFO - ##### 10:17:35 INFO - Running pre-action listener: _resource_record_pre_action 10:17:35 INFO - Running main action method: populate_webroot 10:17:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:17:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:17:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:17:35 INFO - '--tppagecycles', 10:17:35 INFO - '7'], 10:17:35 INFO - 'tests': ['tsvgm']}}, 10:17:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:17:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:17:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:17:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:17:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:35 INFO - 'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:35 INFO - 'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['damp', 'tps']}, 10:17:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:35 INFO - 'tests': ['damp', 'tps']}, 10:17:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['dromaeo_dom']}, 10:17:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:17:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['basic_compositor_video']}, 10:17:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:17:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['a11yr', 10:17:35 INFO - 'ts_paint', 10:17:35 INFO - 'tpaint', 10:17:35 INFO - 'sessionrestore', 10:17:35 INFO - 'sessionrestore_no_auto_restore', 10:17:35 INFO - 'tabpaint']}, 10:17:35 INFO - 'other-e10s': {'tests': ['a11yr', 10:17:35 INFO - 'ts_paint', 10:17:35 INFO - 'tpaint', 10:17:35 INFO - 'sessionrestore', 10:17:35 INFO - 'sessionrestore_no_auto_restore', 10:17:35 INFO - 'tabpaint']}, 10:17:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:17:35 INFO - 'ts_paint', 10:17:35 INFO - 'tpaint', 10:17:35 INFO - 'sessionrestore', 10:17:35 INFO - 'sessionrestore_no_auto_restore', 10:17:35 INFO - 'tabpaint']}, 10:17:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:17:35 INFO - 'ts_paint', 10:17:35 INFO - 'tpaint', 10:17:35 INFO - 'sessionrestore', 10:17:35 INFO - 'sessionrestore_no_auto_restore', 10:17:35 INFO - 'tabpaint']}, 10:17:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['a11yr', 10:17:35 INFO - 'ts_paint', 10:17:35 INFO - 'tpaint', 10:17:35 INFO - 'sessionrestore', 10:17:35 INFO - 'sessionrestore_no_auto_restore', 10:17:35 INFO - 'tabpaint']}, 10:17:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['a11yr', 10:17:35 INFO - 'ts_paint', 10:17:35 INFO - 'tpaint', 10:17:35 INFO - 'sessionrestore', 10:17:35 INFO - 'sessionrestore_no_auto_restore', 10:17:35 INFO - 'tabpaint']}, 10:17:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['tsvgx', 10:17:35 INFO - 'tsvgr_opacity', 10:17:35 INFO - 'tart', 10:17:35 INFO - 'tscrollx', 10:17:35 INFO - 'cart']}, 10:17:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:17:35 INFO - 'tsvgr_opacity', 10:17:35 INFO - 'tart', 10:17:35 INFO - 'tscrollx', 10:17:35 INFO - 'cart']}, 10:17:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:35 INFO - 'talos_options': ['--disable-e10s'], 10:17:35 INFO - 'tests': ['tp5o']}, 10:17:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:35 INFO - 'tests': ['tp5o']}, 10:17:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:35 INFO - 'talos_options': ['--disable-e10s', 10:17:35 INFO - '--xperf_path', 10:17:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:35 INFO - 'tests': ['tp5n']}, 10:17:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:35 INFO - 'talos_options': ['--xperf_path', 10:17:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:35 INFO - 'tests': ['tp5n']}}, 10:17:35 INFO - 'talos.zip': {'path': '', 10:17:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:17:35 INFO - Running post-action listener: _resource_record_post_action 10:17:35 INFO - ##### 10:17:35 INFO - ##### Finished populate-webroot step (success) 10:17:35 INFO - ##### 10:17:35 INFO - ##### 10:17:35 INFO - ##### Running create-virtualenv step. 10:17:35 INFO - ##### 10:17:35 INFO - Running pre-action listener: _resource_record_pre_action 10:17:35 INFO - Running main action method: create_virtualenv 10:17:35 INFO - Creating virtualenv /builds/slave/test/build/venv 10:17:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:17:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:17:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:17:35 INFO - Using real prefix '/usr' 10:17:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:17:35 INFO - Installing distribute.............................................................................................................................................................................................done. 10:17:37 INFO - Installing pip.................done. 10:17:37 INFO - Return code: 0 10:17:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:17:37 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')]} 10:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:37 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')]} 10:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:37 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 0xb6c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b3b0>, '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 0xe2c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2c740>, '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': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:17:37 INFO - Using env: {'DISPLAY': ':0', 10:17:37 INFO - 'HOME': '/home/cltbld', 10:17:37 INFO - 'LANG': 'en_US.UTF-8', 10:17:37 INFO - 'LANGUAGE': 'en_US:en', 10:17:37 INFO - 'LOGNAME': 'cltbld', 10:17:37 INFO - 'MAIL': '/var/mail/cltbld', 10:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:37 INFO - 'MOZ_NO_REMOTE': '1', 10:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:37 INFO - 'NO_EM_RESTART': '1', 10:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:37 INFO - 'PWD': '/builds/slave/test', 10:17:37 INFO - 'SHELL': '/bin/bash', 10:17:37 INFO - 'SHLVL': '1', 10:17:37 INFO - 'TERM': 'linux', 10:17:37 INFO - 'TMOUT': '86400', 10:17:37 INFO - 'USER': 'cltbld', 10:17:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 10:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:37 INFO - '_': '/tools/buildbot/bin/python'} 10:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:17:37 INFO - Cleaning up... 10:17:37 INFO - Return code: 0 10:17:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:17:37 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')]} 10:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:37 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')]} 10:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:37 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 0xb6c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b3b0>, '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 0xe2c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2c740>, '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': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:17:37 INFO - Using env: {'DISPLAY': ':0', 10:17:37 INFO - 'HOME': '/home/cltbld', 10:17:37 INFO - 'LANG': 'en_US.UTF-8', 10:17:37 INFO - 'LANGUAGE': 'en_US:en', 10:17:37 INFO - 'LOGNAME': 'cltbld', 10:17:37 INFO - 'MAIL': '/var/mail/cltbld', 10:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:37 INFO - 'MOZ_NO_REMOTE': '1', 10:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:37 INFO - 'NO_EM_RESTART': '1', 10:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:37 INFO - 'PWD': '/builds/slave/test', 10:17:37 INFO - 'SHELL': '/bin/bash', 10:17:37 INFO - 'SHLVL': '1', 10:17:37 INFO - 'TERM': 'linux', 10:17:37 INFO - 'TMOUT': '86400', 10:17:37 INFO - 'USER': 'cltbld', 10:17:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 10:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:37 INFO - '_': '/tools/buildbot/bin/python'} 10:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:38 INFO - Downloading/unpacking psutil>=3.1.1 10:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:17:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:40 INFO - Installing collected packages: psutil 10:17:40 INFO - Running setup.py install for psutil 10:17:40 INFO - building 'psutil._psutil_linux' extension 10:17:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:17:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:17:40 INFO - building 'psutil._psutil_posix' extension 10:17:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:17:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:17:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:40 INFO - Successfully installed psutil 10:17:40 INFO - Cleaning up... 10:17:40 INFO - Return code: 0 10:17:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:17:40 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')]} 10:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:40 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')]} 10:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:40 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 0xb6c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b3b0>, '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 0xe2c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2c740>, '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': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:17:40 INFO - Using env: {'DISPLAY': ':0', 10:17:40 INFO - 'HOME': '/home/cltbld', 10:17:40 INFO - 'LANG': 'en_US.UTF-8', 10:17:40 INFO - 'LANGUAGE': 'en_US:en', 10:17:40 INFO - 'LOGNAME': 'cltbld', 10:17:40 INFO - 'MAIL': '/var/mail/cltbld', 10:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:40 INFO - 'MOZ_NO_REMOTE': '1', 10:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:40 INFO - 'NO_EM_RESTART': '1', 10:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:40 INFO - 'PWD': '/builds/slave/test', 10:17:40 INFO - 'SHELL': '/bin/bash', 10:17:40 INFO - 'SHLVL': '1', 10:17:40 INFO - 'TERM': 'linux', 10:17:40 INFO - 'TMOUT': '86400', 10:17:40 INFO - 'USER': 'cltbld', 10:17:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 10:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:40 INFO - '_': '/tools/buildbot/bin/python'} 10:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:17:42 INFO - Installing collected packages: mozsystemmonitor 10:17:42 INFO - Running setup.py install for mozsystemmonitor 10:17:42 INFO - Successfully installed mozsystemmonitor 10:17:42 INFO - Cleaning up... 10:17:43 INFO - Return code: 0 10:17:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:17:43 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')]} 10:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:43 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')]} 10:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:43 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 0xb6c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b3b0>, '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 0xe2c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2c740>, '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': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:17:43 INFO - Using env: {'DISPLAY': ':0', 10:17:43 INFO - 'HOME': '/home/cltbld', 10:17:43 INFO - 'LANG': 'en_US.UTF-8', 10:17:43 INFO - 'LANGUAGE': 'en_US:en', 10:17:43 INFO - 'LOGNAME': 'cltbld', 10:17:43 INFO - 'MAIL': '/var/mail/cltbld', 10:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:43 INFO - 'MOZ_NO_REMOTE': '1', 10:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:43 INFO - 'NO_EM_RESTART': '1', 10:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:43 INFO - 'PWD': '/builds/slave/test', 10:17:43 INFO - 'SHELL': '/bin/bash', 10:17:43 INFO - 'SHLVL': '1', 10:17:43 INFO - 'TERM': 'linux', 10:17:43 INFO - 'TMOUT': '86400', 10:17:43 INFO - 'USER': 'cltbld', 10:17:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 10:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:43 INFO - '_': '/tools/buildbot/bin/python'} 10:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:43 INFO - Downloading/unpacking jsonschema==2.5.1 10:17: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 10:17: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 10:17: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 10:17: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 10:17: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 10:17: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 10:17:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:17:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:45 INFO - Downloading functools32-3.2.3-2.tar.gz 10:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:17:45 INFO - warning: no files found matching '*.txt' 10:17:45 INFO - no previously-included directories found matching 'build' 10:17:45 INFO - no previously-included directories found matching 'dist' 10:17:45 INFO - no previously-included directories found matching '.git*' 10:17:45 INFO - Installing collected packages: jsonschema, functools32 10:17:45 INFO - Running setup.py install for functools32 10:17:45 INFO - warning: no files found matching '*.txt' 10:17:45 INFO - no previously-included directories found matching 'build' 10:17:45 INFO - no previously-included directories found matching 'dist' 10:17:45 INFO - no previously-included directories found matching '.git*' 10:17:45 INFO - Successfully installed jsonschema functools32 10:17:45 INFO - Cleaning up... 10:17:45 INFO - Return code: 0 10:17:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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', '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 0xb6c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b3b0>, '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 0xe2c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2c740>, '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': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:17: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 blobuploader==1.2.4 10:17:45 INFO - Using env: {'DISPLAY': ':0', 10:17:45 INFO - 'HOME': '/home/cltbld', 10:17:45 INFO - 'LANG': 'en_US.UTF-8', 10:17:45 INFO - 'LANGUAGE': 'en_US:en', 10:17:45 INFO - 'LOGNAME': 'cltbld', 10:17:45 INFO - 'MAIL': '/var/mail/cltbld', 10:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:45 INFO - 'MOZ_NO_REMOTE': '1', 10:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:45 INFO - 'NO_EM_RESTART': '1', 10:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:45 INFO - 'PWD': '/builds/slave/test', 10:17:45 INFO - 'SHELL': '/bin/bash', 10:17:45 INFO - 'SHLVL': '1', 10:17:45 INFO - 'TERM': 'linux', 10:17:45 INFO - 'TMOUT': '86400', 10:17:45 INFO - 'USER': 'cltbld', 10:17:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 10:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:45 INFO - '_': '/tools/buildbot/bin/python'} 10:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:45 INFO - Downloading/unpacking blobuploader==1.2.4 10:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:47 INFO - Downloading blobuploader-1.2.4.tar.gz 10:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:17:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:17:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:48 INFO - Downloading docopt-0.6.1.tar.gz 10:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:17:48 INFO - Installing collected packages: blobuploader, requests, docopt 10:17:48 INFO - Running setup.py install for blobuploader 10:17:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:17:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:17:48 INFO - Running setup.py install for requests 10:17:48 INFO - Running setup.py install for docopt 10:17:49 INFO - Successfully installed blobuploader requests docopt 10:17:49 INFO - Cleaning up... 10:17:49 INFO - Return code: 0 10:17:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:49 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 0xb6c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b3b0>, '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 0xe2c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2c740>, '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': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:17:49 INFO - Using env: {'DISPLAY': ':0', 10:17:49 INFO - 'HOME': '/home/cltbld', 10:17:49 INFO - 'LANG': 'en_US.UTF-8', 10:17:49 INFO - 'LANGUAGE': 'en_US:en', 10:17:49 INFO - 'LOGNAME': 'cltbld', 10:17:49 INFO - 'MAIL': '/var/mail/cltbld', 10:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:49 INFO - 'MOZ_NO_REMOTE': '1', 10:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:49 INFO - 'NO_EM_RESTART': '1', 10:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:49 INFO - 'PWD': '/builds/slave/test', 10:17:49 INFO - 'SHELL': '/bin/bash', 10:17:49 INFO - 'SHLVL': '1', 10:17:49 INFO - 'TERM': 'linux', 10:17:49 INFO - 'TMOUT': '86400', 10:17:49 INFO - 'USER': 'cltbld', 10:17:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 10:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:49 INFO - '_': '/tools/buildbot/bin/python'} 10:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:49 INFO - Running setup.py (path:/tmp/pip-3J9d_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:49 INFO - Running setup.py (path:/tmp/pip-tNDnVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:49 INFO - Running setup.py (path:/tmp/pip-vbYXwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:49 INFO - Running setup.py (path:/tmp/pip-b2WqFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:49 INFO - Running setup.py (path:/tmp/pip-Qipj3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:49 INFO - Running setup.py (path:/tmp/pip-BuR3GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:49 INFO - Running setup.py (path:/tmp/pip-Rldv2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:49 INFO - Running setup.py (path:/tmp/pip-b_xFOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:49 INFO - Running setup.py (path:/tmp/pip-jgVbLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:49 INFO - Running setup.py (path:/tmp/pip-uPF0fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:50 INFO - Running setup.py (path:/tmp/pip-ZJjeGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:50 INFO - Running setup.py (path:/tmp/pip-t4KsUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:50 INFO - Running setup.py (path:/tmp/pip-SxmLbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:50 INFO - Running setup.py (path:/tmp/pip-CDVeQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:50 INFO - Running setup.py (path:/tmp/pip-kSwPxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:50 INFO - Running setup.py (path:/tmp/pip-odlL_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:50 INFO - Running setup.py (path:/tmp/pip-XcScGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:17:50 INFO - Running setup.py install for manifestparser 10:17:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:17:50 INFO - Running setup.py install for mozcrash 10:17:50 INFO - Running setup.py install for mozdebug 10:17:50 INFO - Running setup.py install for mozdevice 10:17:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:17:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Running setup.py install for mozfile 10:17:51 INFO - Running setup.py install for mozhttpd 10:17:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Running setup.py install for mozinfo 10:17:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Running setup.py install for mozInstall 10:17:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Running setup.py install for mozleak 10:17:51 INFO - Running setup.py install for mozlog 10:17:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Running setup.py install for moznetwork 10:17:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Running setup.py install for mozprocess 10:17:51 INFO - Running setup.py install for mozprofile 10:17:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Running setup.py install for mozrunner 10:17:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Running setup.py install for mozscreenshot 10:17:52 INFO - Running setup.py install for moztest 10:17:52 INFO - Running setup.py install for mozversion 10:17:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:17:52 INFO - Cleaning up... 10:17:52 INFO - Return code: 0 10:17:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:52 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 0xb6c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b3b0>, '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 0xe2c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2c740>, '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': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:17:52 INFO - Using env: {'DISPLAY': ':0', 10:17:52 INFO - 'HOME': '/home/cltbld', 10:17:52 INFO - 'LANG': 'en_US.UTF-8', 10:17:52 INFO - 'LANGUAGE': 'en_US:en', 10:17:52 INFO - 'LOGNAME': 'cltbld', 10:17:52 INFO - 'MAIL': '/var/mail/cltbld', 10:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:52 INFO - 'MOZ_NO_REMOTE': '1', 10:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:52 INFO - 'NO_EM_RESTART': '1', 10:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:52 INFO - 'PWD': '/builds/slave/test', 10:17:52 INFO - 'SHELL': '/bin/bash', 10:17:52 INFO - 'SHLVL': '1', 10:17:52 INFO - 'TERM': 'linux', 10:17:52 INFO - 'TMOUT': '86400', 10:17:52 INFO - 'USER': 'cltbld', 10:17:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 10:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:52 INFO - '_': '/tools/buildbot/bin/python'} 10:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:52 INFO - Running setup.py (path:/tmp/pip-n6XRjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:52 INFO - Running setup.py (path:/tmp/pip-WoYF9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:52 INFO - Running setup.py (path:/tmp/pip-uMuVbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:52 INFO - Running setup.py (path:/tmp/pip-aBSGEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:52 INFO - Running setup.py (path:/tmp/pip-NaWQmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:52 INFO - Running setup.py (path:/tmp/pip-SMFSeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:53 INFO - Running setup.py (path:/tmp/pip-moRuTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:53 INFO - Running setup.py (path:/tmp/pip-hu7mKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:53 INFO - Running setup.py (path:/tmp/pip-n0owtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:53 INFO - Running setup.py (path:/tmp/pip-u77m0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:53 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)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:53 INFO - Running setup.py (path:/tmp/pip-PNn4hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:53 INFO - Running setup.py (path:/tmp/pip-8y8sRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:53 INFO - Running setup.py (path:/tmp/pip-xfDC5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:53 INFO - Running setup.py (path:/tmp/pip-bwSow1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:53 INFO - Running setup.py (path:/tmp/pip-KiULrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:53 INFO - Running setup.py (path:/tmp/pip-ygcWU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:53 INFO - Running setup.py (path:/tmp/pip-k8SnP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:17:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:55 INFO - Downloading blessings-1.6.tar.gz 10:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:17:55 INFO - Installing collected packages: blessings 10:17:55 INFO - Running setup.py install for blessings 10:17:55 INFO - Successfully installed blessings 10:17:55 INFO - Cleaning up... 10:17:55 INFO - Return code: 0 10:17:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:17:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:56 INFO - Reading from file tmpfile_stdout 10:17:56 INFO - Current package versions: 10:17:56 INFO - argparse == 1.2.1 10:17:56 INFO - blessings == 1.6 10:17:56 INFO - blobuploader == 1.2.4 10:17:56 INFO - docopt == 0.6.1 10:17:56 INFO - functools32 == 3.2.3-2 10:17:56 INFO - jsonschema == 2.5.1 10:17:56 INFO - manifestparser == 1.1 10:17:56 INFO - mozInstall == 1.12 10:17:56 INFO - mozcrash == 0.17 10:17:56 INFO - mozdebug == 0.1 10:17:56 INFO - mozdevice == 0.48 10:17:56 INFO - mozfile == 1.2 10:17:56 INFO - mozhttpd == 0.7 10:17:56 INFO - mozinfo == 0.9 10:17:56 INFO - mozleak == 0.1 10:17:56 INFO - mozlog == 3.2 10:17:56 INFO - moznetwork == 0.27 10:17:56 INFO - mozprocess == 0.23 10:17:56 INFO - mozprofile == 0.28 10:17:56 INFO - mozrunner == 6.12 10:17:56 INFO - mozscreenshot == 0.1 10:17:56 INFO - mozsystemmonitor == 0.3 10:17:56 INFO - moztest == 0.7 10:17:56 INFO - mozversion == 1.4 10:17:56 INFO - psutil == 3.1.1 10:17:56 INFO - requests == 1.2.3 10:17:56 INFO - wsgiref == 0.1.2 10:17:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:56 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 0xb6c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b3b0>, '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 0xe2c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2c740>, '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': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:17:56 INFO - Using env: {'DISPLAY': ':0', 10:17:56 INFO - 'HOME': '/home/cltbld', 10:17:56 INFO - 'LANG': 'en_US.UTF-8', 10:17:56 INFO - 'LANGUAGE': 'en_US:en', 10:17:56 INFO - 'LOGNAME': 'cltbld', 10:17:56 INFO - 'MAIL': '/var/mail/cltbld', 10:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:56 INFO - 'MOZ_NO_REMOTE': '1', 10:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:56 INFO - 'NO_EM_RESTART': '1', 10:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:56 INFO - 'PWD': '/builds/slave/test', 10:17:56 INFO - 'SHELL': '/bin/bash', 10:17:56 INFO - 'SHLVL': '1', 10:17:56 INFO - 'TERM': 'linux', 10:17:56 INFO - 'TMOUT': '86400', 10:17:56 INFO - 'USER': 'cltbld', 10:17:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 10:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:56 INFO - '_': '/tools/buildbot/bin/python'} 10:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:17:56 INFO - Cleaning up... 10:17:56 INFO - Return code: 0 10:17:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b3b0>, '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 0xe2c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2c740>, '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': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:17:56 INFO - Using env: {'DISPLAY': ':0', 10:17:56 INFO - 'HOME': '/home/cltbld', 10:17:56 INFO - 'LANG': 'en_US.UTF-8', 10:17:56 INFO - 'LANGUAGE': 'en_US:en', 10:17:56 INFO - 'LOGNAME': 'cltbld', 10:17:56 INFO - 'MAIL': '/var/mail/cltbld', 10:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:56 INFO - 'MOZ_NO_REMOTE': '1', 10:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:56 INFO - 'NO_EM_RESTART': '1', 10:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:56 INFO - 'PWD': '/builds/slave/test', 10:17:56 INFO - 'SHELL': '/bin/bash', 10:17:56 INFO - 'SHLVL': '1', 10:17:56 INFO - 'TERM': 'linux', 10:17:56 INFO - 'TMOUT': '86400', 10:17:56 INFO - 'USER': 'cltbld', 10:17:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 10:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:56 INFO - '_': '/tools/buildbot/bin/python'} 10:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:17:56 INFO - Cleaning up... 10:17:56 INFO - Return code: 0 10:17:56 INFO - Running post-action listener: _resource_record_post_action 10:17:56 INFO - Running post-action listener: _start_resource_monitoring 10:17:56 INFO - Starting resource monitoring. 10:17:56 INFO - ##### 10:17:56 INFO - ##### Finished create-virtualenv step (success) 10:17:56 INFO - ##### 10:17:56 INFO - ##### 10:17:56 INFO - ##### Running install step. 10:17:56 INFO - ##### 10:17:56 INFO - Running pre-action listener: _resource_record_pre_action 10:17:56 INFO - Running main action method: install 10:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:56 INFO - Reading from file tmpfile_stdout 10:17:56 INFO - Detecting whether we're running mozinstall >=1.0... 10:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:17:56 INFO - Reading from file tmpfile_stdout 10:17:56 INFO - Output received: 10:17:56 INFO - Usage: mozinstall [options] installer 10:17:56 INFO - Options: 10:17:56 INFO - -h, --help show this help message and exit 10:17:56 INFO - -d DEST, --destination=DEST 10:17:56 INFO - Directory to install application into. [default: 10:17:56 INFO - "/builds/slave/test"] 10:17:56 INFO - --app=APP Application being installed. [default: firefox] 10:17:56 INFO - mkdir: /builds/slave/test/build/application 10:17:56 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'] 10:17:56 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 10:18:13 INFO - Reading from file tmpfile_stdout 10:18:13 INFO - Output received: 10:18:13 INFO - /builds/slave/test/build/application/firefox/firefox 10:18:13 INFO - Running post-action listener: _resource_record_post_action 10:18:13 INFO - ##### 10:18:13 INFO - ##### Finished install step (success) 10:18:13 INFO - ##### 10:18:13 INFO - ##### 10:18:13 INFO - ##### Running run-tests step. 10:18:13 INFO - ##### 10:18:13 INFO - Running pre-action listener: _resource_record_pre_action 10:18:13 INFO - Running main action method: run_tests 10:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:18:13 INFO - Python 2.7.3 10:18:13 INFO - Return code: 0 10:18:13 INFO - grabbing minidump binary from tooltool 10:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:18:13 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 0xe2b3b0>, '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 0xe2c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:18:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:18:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:18:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:18:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:18:13 INFO - Return code: 0 10:18:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:18:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:18:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:18:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:18:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:18:13 INFO - Using env: {'DISPLAY': ':0', 10:18:13 INFO - 'HOME': '/home/cltbld', 10:18:13 INFO - 'LANG': 'en_US.UTF-8', 10:18:13 INFO - 'LANGUAGE': 'en_US:en', 10:18:13 INFO - 'LOGNAME': 'cltbld', 10:18:13 INFO - 'MAIL': '/var/mail/cltbld', 10:18:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:13 INFO - 'MOZ_NO_REMOTE': '1', 10:18:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:13 INFO - 'NO_EM_RESTART': '1', 10:18:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:13 INFO - 'PWD': '/builds/slave/test', 10:18:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:13 INFO - 'SHELL': '/bin/bash', 10:18:13 INFO - 'SHLVL': '1', 10:18:13 INFO - 'TERM': 'linux', 10:18:13 INFO - 'TMOUT': '86400', 10:18:13 INFO - 'USER': 'cltbld', 10:18:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483', 10:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:13 INFO - '_': '/tools/buildbot/bin/python'} 10:18:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:18:13 INFO - mozversion application_buildid: 20160709085426 10:18:13 INFO - mozversion application_changeset: 679118259e91f40d4a8f968f03ec4cff066cdb5b 10:18:13 INFO - mozversion application_display_name: Nightly 10:18:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:18:13 INFO - mozversion application_name: Firefox 10:18:13 INFO - mozversion application_remotingname: firefox 10:18:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:18:13 INFO - mozversion application_vendor: Mozilla 10:18:13 INFO - mozversion application_version: 50.0a1 10:18:13 INFO - mozversion platform_buildid: 20160709085426 10:18:13 INFO - mozversion platform_changeset: 679118259e91f40d4a8f968f03ec4cff066cdb5b 10:18:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:18:13 INFO - mozversion platform_version: 50.0a1 10:18:13 INFO - using testdate: 1468084693 10:18:13 INFO - actual date: 1468084693 10:18:13 INFO - starting webserver on 'localhost:42009' 10:18:13 INFO - SUITE-START | Running 2 tests 10:18:13 INFO - TEST-START | dromaeo_css 10:18:13 INFO - operating with platform_type : linux_ 10:18:13 INFO - Initialising browser for dromaeo_css test... 10:18:13 INFO - TEST-INFO | started process 20673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpicFlff/profile http://localhost:42009/getInfo.html) 10:18:17 INFO - PROCESS | 20673 | __metrics Screen width/height:1600/1200 10:18:17 INFO - PROCESS | 20673 | colorDepth:24 10:18:17 INFO - PROCESS | 20673 | Browser inner width/height: 1024/697 10:18:17 INFO - PROCESS | 20673 | __metrics 10:18:18 INFO - PROCESS | 20673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:18:18 INFO - PROCESS | 20673 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:18:19 INFO - TEST-INFO | 20673: exit 0 10:18:19 INFO - Browser initialized. 10:18:19 INFO - Running cycle 1/1 for dromaeo_css test... 10:18:19 INFO - TEST-INFO | started process 20755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpicFlff/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:31 INFO - PROCESS | 20755 | RSS: Main: 159584256 10:18:31 INFO - PROCESS | 20755 | 10:19:23 INFO - PROCESS | 20755 | 1468084763497 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:21:34 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:42009/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42009/tests/dromaeo/cssquery-ext.html) 10:21:36 INFO - PROCESS | 20755 | RSS: Main: 288956416 10:21:36 INFO - PROCESS | 20755 | 10:24:38 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:42009/tests/dromaeo/cssquery-ext.html (next: http://localhost:42009/tests/dromaeo/cssquery-jquery.html) 10:24:39 INFO - PROCESS | 20755 | RSS: Main: 245493760 10:24:39 INFO - PROCESS | 20755 | 10:27:41 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:42009/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42009/tests/dromaeo/cssquery-mootools.html) 10:27:42 INFO - PROCESS | 20755 | RSS: Main: 246427648 10:27:42 INFO - PROCESS | 20755 | 10:30:44 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:42009/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42009/tests/dromaeo/cssquery-prototype.html) 10:30:45 INFO - PROCESS | 20755 | RSS: Main: 238112768 10:30:45 INFO - PROCESS | 20755 | 10:33:48 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:42009/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42009/tests/dromaeo/cssquery-yui.html) 10:33:48 INFO - PROCESS | 20755 | RSS: Main: 220311552 10:33:48 INFO - PROCESS | 20755 | 10:36:51 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:42009/tests/dromaeo/cssquery-yui.html (next: http://localhost:42009/tests/dromaeo/cssquery-dojo.html) 10:36:52 INFO - PROCESS | 20755 | RSS: Main: 270712832 10:36:52 INFO - PROCESS | 20755 | 10:36:52 INFO - PROCESS | 20755 | __start_tp_report 10:36:52 INFO - PROCESS | 20755 | _x_x_mozilla_page_load 10:36:52 INFO - PROCESS | 20755 | _x_x_mozilla_page_load_details 10:36:52 INFO - PROCESS | 20755 | |i|pagename|runs| 10:36:52 INFO - PROCESS | 20755 | |0;dojo.html;2533.5312967101086;2533.708623508297;2575.7424257574244;2580.1614475295523;2584.728603496633;4423.911521769563;4480.171168333853;4524.389207456992;4573.679842411033;4575.062112266982;4500.639948804096;4517.909641807162;4521.638268938485;4575.359449677047;4594.609458196057;3942.152437225996;4111.0544574747755;4174;4204.11713540157;4318.805653745589;4221.071364299849;4291.163223171483;4292.935605965898;4295.742255464682;4333.393324934512;4131.215069136884;4146.668266538685;4167.1040726244;4196.139791342767;4215.557366476506;4130.318497447917;4197.160567886435;4208.600182982612;4218.578142185787;4251.489821221442;4160.167966406731;4161.958380416218;4184.267753143218;4193.245215861144;4196.202721482909;4455.242608756519;4503.774811259456;4557.453105627313;4612.95387046132;4623.653226008063;4869;4881.658283920127;4893.828715994959;4910.386201724785;4918.778654960535;4698.741569213692;4714.057188562301;4882.560569548722;4901.632377571696;4924.43369012561;4439.7780110994645;4503.986603014296;4508.413906192174;4510.954890451119;4513.864584062483;4903.754812259373;4930.334404855299;4932.062908047531;4937.382827146606;4937.7777999990085;4637.397138372057;4649.5350464953235;4658;4725.692829966041;4737.123632128068;4778.474367819537;4795.568398844121;4833.830815921426;4836.5888899443235;4839.951600484021;4742.312364707167;4750.216214324598;4757.333973243749;4770.236762118045;4805.543473370024;4644.001539668988;4726.125666751662;4729.787159577827;4743.193657078305;4769.998300356964;4123.793810309473;4151.605597468236;4153.044799696087;4195.223883581547;4213;3617.0595645132457;3645.872394466234;3654.1230104775195;3673.577538583044;3678.2459595782802;4126.42230087788;4161.10536234711;4176.812043458051;4203.789810509462;4209.831606735696;4827.179379505493;4849.733264670477;4850.345203397496;4855.465898751135;4899.044686286211;4194.266003449384;4214.220369231702;4222.451081359403;4226.556211597799;4253.043065310342;4333.349997500401;4340;4381.123775244963;4411.985243394038;4420.646348292129;4567.38340324052;4570.88572785683;4581.198290299118;4597.977010114928;4604.815807367668;4805.711657300573;4806.831760888352;4808.422989241313;4823.517648235148;4854.75726213695;4529.796159172779;4556.703814252063;4573.702709323883;4615.030843522898;4621.491635920113;4784.617230621611;4787.018661174381;4788.832390866303;4790.137775200497;4821.493743156918;4825.9758701206265;4843.951560484491;4849.830255941025;4851.927221091757;4901.215805471107;4617.769111544477;4653.837115700934;4661.160991021648;4712.434507859079;4717.103750287434;4694.413198350207;4709.222978208694;4714.929276060793;4715.104130215248;4720.787564559534;4597.149527337453;4616.49218585962;4653.395058642355;4657.184992626209;4673.883152921204;4774.809007639795;4781.330613714153;4786.688865223749;4820.39745031871;4820.903581928272;4657.022025374709;4664.440267167826;4665.48679645232;4669.929951050805;4717.811287548459 10:36:52 INFO - PROCESS | 20755 | |1;ext.html;570.997145014275;577.0939624789078;579.4437340153453;582.1965687351452;586.609904413565;26682.86658566707;27277.59083613745;38867.02832429191;39712.014399280066;39882;39231.607683923154;39710.40434393486;39715.80142099285;39719;39792.60207397925;7768.417368697356;7906.486078404914;7911.050673919138;7912.920870791305;7915.6042197890165;7732.381409487228;7815.687372505093;7822.843543129134;7823.843523129534;7828.217178282155;7834.216578342149;7882.054153501588;7884.526928384286;7890.56601886896;7893.526388416684;7782.18287079857;7794.532328060278;7814.452988290822;7819.64811583483;7829.060512738451;7771.339436147934;7833.177516360757;7842.490238134503;7843.137254901956;7843.450958432912;38034.619653803384;38142.23715525702;38324.616753832386;38331.23337533234;38395;2861.948660613997;3048.923776905573;3051.6032915721034;3123.047470521513;3418.67522585354;28737.42525149506;28814.135575932756;28852.567211491845;29170.124896253146;29635.703642963508;3460.636633153533;3463.428534291839;3483.9129021774406;3502.317048175607;3592.892213233581;250368;250704;250740;250963.74518127475;251091;31604.841975789976;48906;49466;49471.78433401817;49572.25641615379;31889.681103189134;33516.3296734064;33557.66442335594;33632.15919602029;33640.1589960253;13092.410841512155;13165.53920612774;13174.670633234055;13202.273874936971;13224.669383265495;10717.356958582353;10802.189835762192;10803.243772935819;10832.67501974942;10832.945835270773;7737.613119344122;7767.572783496849;7788.14330423653;7854.332381747501;7865.842683146305;3110.4712198926236;3126.89055883043;3141.0733833519166;3161.1780936956097;3161.7944833585743;851.8849955256085;892.3173772064376;899.1368286444955;942.4675058591873;946.3895787217207;27377.31556711058;27435.17694469169;27664.58503122455;27906.581401278996;27960.86019569889;943.2077055273603;967.1150896929231;996.342414006752;997.3417544420647;1019.8011387779312;14308.356123974447;14691.85308146905;14703.705925881422;14804.333804978802;15026.624334391729;371982;374566;376572;377539.11230443674;377665;48365;48862;48977;49044.50955490399;49076.018479630206;1053.4627340056472;1153.2734377342222;1183.230899915062;1199.9280043197436;1204.0488014468472;27722;28458.715412845606;28676.42647147087;29030.41939161247;29311.7068829309;35433.82283088568;35487.290254195286;35696.464553031205;35701.46447803337;35754.821225894746;294398;297383;297986;297986;298851;22119.889400552893;24261.757382426655;24763.13329033475;24882.377940551632;25079.373015674755;38743.41884871673;38979.2204155921;39858.402123967586;40804.79597601993;41657.1668566633;36015;36133.63866361303;36141.819290903375;36503.817480912425;36704.26591468209;35926.12095259825;36151;36289.63710362863;36568.26863462769;36683.266334672626;35242.47136293009;35686.28627427489;35974.82012590025;36174.27651447009;36272.81863590665;31569.8421507891;32612.673873260963;32677.836610816794;32679.836600816845;32734.181645459055;24715;24808.627870582317;25122.623160652238;25272.36819079464;25329.49341013206 10:36:52 INFO - PROCESS | 20755 | |2;jquery.html;332.0536471057485;366;368.86167687117324;372.6348178784791;387.7053439386066;12950.54673086441;16293.83706162938;16893.493195204162;17318.913405432955;18277.725834112465;16581.91709041456;17319.82680173198;17687.646247075052;17691.380801671945;17696.82303176971;5142.460041695615;6742.629155396451;7125.3230943060325;7160.785176444715;7178.892316615229;4154.376843473473;6654.733810647593;6955.791326260221;7056.611886346249;7076.752313668997;6901.723931042752;7038.15542134942;7151.642417879111;7192.31672991065;7193.172785129698;7139.535930164523;7174.928250717504;7195.352418282379;7198.172210195816;7236.8552628947655;6694.93305066948;6926.168859736814;6929.930700693029;6959.164900211957;6960.965195173992;23053.308400747836;23289;23303.417414564603;23406.882965585235;24196.274111776675;2038.5718999010226;2100.506381000479;2133.0294715904224;2165.4261620670536;2221.6445368741083;14349.497767578085;14766.26168691572;14923.858877826035;14934.701305973927;14981.101133932;1873.7376767252595;1901.9239230430906;1912.7800302965197;1983.1274239334791;2004.5189154602936;80562;81649;82108;82462.58768706178;83258;13841.930790345983;14742.673159415705;16022.679546409006;16918.238679259215;17141.48575542736;10604.310719803343;28869.56695649567;28937;28995;29059;7003.684834182474;7126.216116227314;7135.179454362711;7207.675654595556;7211.242819503981;6318.178636777189;6353.555251132469;6797.218319893177;6849.04113424121;7203.423726102004;3782.1467480934143;3835.9808200959374;3867.0719027433774;3889.202713443794;3909.081365879016;1845.7323688065155;1854.573448106943;1884.406411980222;1892.6782446984046;1906.170815695177;679.4055201698513;694.6075467361026;717.1573401253506;726.9491135620456;776.0338378718532;16200.270987805578;16324.347026118823;16350.591235219215;16494.2577584009;16776.748348774778;694.2432748304373;737.8339873528413;744.5346658338539;752.450710980987;785.3299572717252;8983.865242021375;8987.55062246885;9041.63833446668;9044.276457883354;9173.862392064124;346192;361082;362626;362849;363485;78235.74114070974;78321.60839195881;78566;78746;78960;890.9153630404971;899.4153800030033;902.3232575568323;923.8337099322052;928.4058202750246;11860.19347689378;15567.143807090266;15652.530424087296;15677.137757423452;15984.360625575311;38483.73089048824;39358;39588.20823583454;39702;40799.79600102099;48960;49125;49339;49771.50228497669;50133.24800127928;4701.788419521198;4817.325574419514;6540.542162048611;6578.210614726264;7032.593481303657;11487;11582.131340149692;11655.941720291345;11804.173707840711;12043.879561204276;9671.468069256258;9757.219422446045;10076.294659374067;10244.385336879812;10538.367697938149;9443.433393996382;9792.85310720354;9936.155426788804;9959.352642078242;10329.32859364169;8862.734117976472;9562.091601297865;9694.6122155113;10574.471276436301;10577.9471102644;7264.455165862687;7484.850302994018;7490.887636685345;7657.042869641295;7756.534607923542;9550.665726699532;10034.448105354275;10132.848007279748;10225.744356390853;10450.947745261225 10:36:52 INFO - PROCESS | 20755 | |3;mootools.html;1363.481876886783;1411.4354258296682;1471.168395347792;1654.3878764857004;1676.0530300380285;7286.963565182174;7706.460547761659;7776.53340799551;7783.64973576189;7788.6884524618945;6413.198350206224;7034.15590129184;7227.566346019243;7240.710371585144;7675.462717609769;2135.9679604805942;2164.7943445372744;2166.2309879992613;2169.913203471859;2170.5007848194846;1847.3718935561906;2159.5249045210107;2169.3166652504488;2199.714037175173;2203.526241858;2060.2994981706215;2139.101577337522;2142.5607750411205;2156.1590979518;2162.697222388867;2121.1727426303755;2126.7022616833656;2146.152269853415;2185.2133232036454;2187.4203336115784;2111.102781317949;2115.1645100185497;2118.66101423773;2118.8622739521884;2120.8091271785615;7720.459567830254;7742.264484873928;7750.883736743954;7753.806154846117;7765.611719414063;4418.668599854992;4441.244988351988;4500.977495112536;4510.481294651125;4527;2706.6751989761356;2801.229661842989;2835.744782969522;2844.033028770228;2844.33158207821;886.3529623374908;890.3322508118911;894.9463032218023;908.4413085952092;917.7797328641145;10195.541200645914;10225.795484090351;10239.48802559869;10272.332298400655;10276.229282803744;3918.804059796999;4099.426080348753;4102.733322334038;4113.670906327487;4205.17998990194;8749.518776467228;8802.86795698065;8821.911780882108;8825.955870220736;8853.247473964657;4487.057717879282;4489.708168969007;4489.9775501122285;4492.752898590609;4515.503294637587;4015.13674559971;4104.220198162339;4109.260333140063;4112.259793237246;4120.7321524100835;3375.696187343151;3452.5166476693284;3491.266833964896;3515.2442224921765;3526.1360966563357;964;1028.2596530498179;1040.2354269611828;1041.8958104189521;1072.158355690779;678.6097993653669;707.678006507038;710.886258198696;715.9606221657755;717.8348979734691;4753.953736424179;4761.452432970253;4871.244957031666;4931.334269873593;4939.654224204343;783.1815752538611;794.3803833010261;801.8155824160359;841.5329492131925;868.7306934850217;3070.78504504687;3200.1839530919465;3201.9679803202134;3202.167436466489;3260.6087269527807;9222.53887305632;9479.715608531755;9581.712548623413;9583.472908990072;9598;8444.831103377897;8866.33502487316;9357.672481463116;9482.525873706425;9499.192568631745;6861.210960739579;7074.080369552028;7095.219525852152;7096.680649370791;7102.4318054555515;5256.658317209369;5289.074411977812;5379.973100134631;5463.07127788269;5478.369987451494;8402.11777763326;8628;8697.6086076128;8753.956230218808;8784.297256219616;8853.38026338176;8868.911310887066;8947.552622368725;8996.910030899608;9030.096990300917;6171.105189747551;6190.969045154926;6227.750889964351;6239.282482514569;6255.093011513214;7011.053507776589;7011.754588589375;7066.258042905626;7111.502194846311;7125.35871771543;5507.669539827623;5509.393966663744;6228.906566401417;6239.251289845248;6387.936120638734;5991.621294465082;6095.756169753337;6160.291566469913;6198.907016394848;6268.091126786681;5960.731767070405;5986.610870293417;6015.097735339734;6025.8192254232445;6026.819195424145;4185.790710464526;4214.325707886724;4301.978490107529;4305.634021108241;4326.58897404746;4171.499420069611;4327.778274652401;4420.58004489573;4476.552344765498;4489.573490518395 10:36:52 INFO - PROCESS | 20755 | |4;prototype.html;290.3018241130083;293.7048266492175;300.6542476152425;302.92426893276684;307.86761692472226;4693.460252071013;4715.90568188636;4733.739644319561;4745.122152401804;4767.404074490689;4432.734035957845;4441.800118994645;4544.295634176699;4647.953520464795;4690.859274221771;3711.8144092795387;3729.7762134271893;3730.2912446635187;3732.5894151643433;3744.794036328001;3728.6949567651377;3752.2683076800035;3754.49314342563;3771.41543060826;3773.9622603773887;3558.626344233857;3578.3916734155255;3720.8325625346924;3721.1069343357535;3731.365667836474;3685.7051435885332;3691.963080369189;3694.685951694109;3706.7405281630295;3728.291624591319;3295.9011229663147;3303.966960330414;3304.9424184261047;3305.8512366943546;3312.635610082889;4472.485664148599;4558.680892337537;4587.72473651582;4593.724376537419;4596.816127354902;4234.872953811359;4257.106007738348;4261.659067274611;4263.744175349489;4265.552117027699;4864.246041863482;4871.56155945963;4871.683340582851;4879.438864530589;4910.263460480921;3619.7647152934974;3620.5655321361605;3623.4927110204594;3649.069487280753;3649.1424515238896;4945.752712364368;5083.135866902636;5085.593152547787;5112.872178195537;5117.513836185556;3679.9264014720093;3690.446433035066;3690.760100593453;3695.371786796251;3709.8330575124182;3746.9063273417837;3748.887533374003;3750.2686976039954;3758.2671379080816;3771.660550550409;3927.19492504036;4150.584941505886;4208.9789551052045;4213.789310534461;4232.534421213664;4902.921357301388;4913.459519452857;4914.336564563738;4917.754112294371;4920.975395123001;1193.433119268358;1251.6620512461584;1255.2029461292145;1266.6643339515035;1305.8171855940177;886.2511178054533;900.2977677411629;920.2729843423621;920.7559996600907;921.5944984206927;3897.2595206910596;3906.628870257321;3931.623931623909;3932.7583277532103;3937.42907278443;4448.532904045093;4457.375967364572;4469.463664360298;4470.262406702923;4489.349044388546;3866.5940076292145;3894.9610503895165;3900.620621420931;3901.205445495047;3916.4712763776524;2381.72610149835;2384.225126833786;2484.5403600334;2687.1535466328046;2691.9596206056926;4822.156122678517;4838.927416088762;4848.0788650156355;4862.5380588844;4868.269759536027;5192.480751924777;5196.506331898464;5201.661891977009;5218.686878787209;5236.895262094737;4626.282926146453;4823.300621409946;4845.781939812717;4858.878528036827;4893.437254715682;5045.974770126126;5050.621203409685;5061.9493805061475;5072.21028434367;5100.132977393778;4954.826581069645;4973.204287314013;4986.3295795907325;5002.424721156968;5005.473330634191;4616.192166370939;4846.297286893451;4878.487758785276;4888.462269150462;4891.682040667345;3628.2380700053286;3642.6721595056574;3648.854045838243;3656.762310449812;3660.865131809148;4858.368412106403;5095.898082038412;5099.5410413063;5099.949000510096;5116.155834287301;4786.305985631994;4942.802287908444;4965.329680493087;4972.552470277692;4978.576820970258;4925.778339974781;4927.556519913225;4928.137575924127;4940.7035577865445;4945.975270123627;4567.566081222279;4875.878103047452;4880.560234730692;4887.095887260868;4901.558859702502;4911.263310503453;4953.083679519301;4966.528179822911;4989.201727723546;4991.450940396626;4835.734034628129;4840.7337596432535;4854.83008094715;4879.80480780779;4896.583790377857 10:36:52 INFO - PROCESS | 20755 | |5;yui.html;566.8299510146957;577.0853197681674;611.3313218560809;629.9055141728743;641.5797652537586;11722.706932326697;12888.806667899977;13456.327183640828;13955.232462214573;13988.440462381517;13069.346532673377;13132.080754347176;13179.143355681874;13243.072984891038;13257.734845303088;619.6870580356914;745.4930647159929;760.3992845651942;781.0315209140681;787.7991112266365;773.97678069658;782.4444644302523;782.7769085810545;782.9804254893617;783.6669415498419;808.6037841457672;813.2802469814197;814.9959250203741;815.3151352863594;815.5392203405087;640.932702066281;779.949303295284;807.7132617920671;809.7489778168787;810;592.1354821959943;592.2744637818681;592.4460629311608;592.602956019468;593.2139914613155;12827.807582886264;12916;12940.741185176337;12950.935245323808;12972.935135324356;11311.886881131166;11685.532578696842;11723.531058757639;11746.236494627821;11863.940680296544;11046;11103.44482775858;11141.832872506919;11142.944285278603;11158.665240042812;4047.402733544304;4074.7555146691293;4090.7396824607927;4096.938545921814;4151.232022075926;52726;55507.44492555063;55575.16637250444;64181.358186418474;65295.3470465294;9687.564059617334;9942.254330925209;9951.601935922483;9983.750406239757;10081.798364032826;16923.57691057709;17293.308267669152;17555.473335799947;17583;18218.54453638643;6559.147310849559;6599.307072757388;6607.900881486686;6623.735050597922;6882.346177113266;3730.235301763132;3752.6622603965775;3817.923641527154;3846.3653497172654;3892.6691231245095;2572.4469239113305;2690.704022557517;2696.7303269672875;2698.123109989261;2703.8242514236513;493.0779442442655;504.20587574569464;513.1302442360238;513.5095983335905;515.7498613172609;471.8466498387969;535.788363596385;548.101114172757;556.1490918894018;561.0630247486707;7933.365330773524;8000.799980000546;8083.272505474418;8093.595320233965;8253.566019619328;535.5207089654738;538.2491424462852;548.1175307754512;558.1961974756338;563.2171281918137;3635.4365073413665;3873.573906870242;3919.627635374635;3937.9606203938165;4033.415154802537;104538.47730761298;105565.47217263865;106439.46780266204;110140;110504;79896.60051699704;83447.5827620858;83912;91036;93295.53352233196;45545.861353466425;57201;69146.65426672835;69166.65416672884;72725.2727472729;8133.349332053303;8206.302464290602;8246.958765206136;8520.74437766868;8706.825863482569;42625.14749705051;43665.56334436615;44288.33567496554;44564.77717611521;44801.77599112114;55416.72291638516;55417.1687424697;58566.707166465596;63699.36300636934;64696.353036470915;10661.57353705874;10749.570017199225;10898.727531811768;11005.229633925548;11014;12511.186772859735;12517.749645006867;12690.809637855624;12847.229166250056;13064.412101455267;11210.66368008961;11810.173287869766;11857.5849845255;11943.641690749291;12308.938455307667;10877.456127193767;11230.494627741607;11278.718032049264;11679.240849344766;11682.24065435744;10948.945255273673;11503.48234329474;11845.170838041598;11851.822222666839;11860.762784744084;9567.37812042215;9629.181519570635;9720.805583888141;10056.245781566558;10068.295219334575;8973.416727912665;9313.674021409219;9574.952125239608;9608.9039109608;9769.071938165864 10:36:52 INFO - PROCESS | 20755 | __end_tp_report 10:36:52 INFO - PROCESS | 20755 | __start_cc_report 10:36:52 INFO - PROCESS | 20755 | _x_x_mozilla_cycle_collect,1200 10:36:52 INFO - PROCESS | 20755 | __end_cc_report 10:36:52 INFO - PROCESS | 20755 | __startTimestamp1468085812035__endTimestamp 10:36:52 INFO - PROCESS | 20755 | 10:36:52 INFO - PROCESS | 20755 | ------- Summary: start ------- 10:36:52 INFO - PROCESS | 20755 | Number of tests: 6 10:36:52 INFO - PROCESS | 20755 | 10:36:52 INFO - PROCESS | 20755 | [#0] dojo.html Cycles:165 Average:4480.82 Median:4612.95 stddev:450.68 (9.8%) stddev-sans-first:425.38 10:36:52 INFO - PROCESS | 20755 | Values: 2533.5 2533.7 2575.7 2580.2 2584.7 4423.9 4480.2 4524.4 4573.7 4575.1 4500.6 4517.9 4521.6 4575.4 4594.6 3942.2 4111.1 4174.0 4204.1 4318.8 4221.1 4291.2 4292.9 4295.7 4333.4 4131.2 4146.7 4167.1 4196.1 4215.6 4130.3 4197.2 4208.6 4218.6 4251.5 4160.2 4162.0 4184.3 4193.2 4196.2 4455.2 4503.8 4557.5 4613.0 4623.7 4869.0 4881.7 4893.8 4910.4 4918.8 4698.7 4714.1 4882.6 4901.6 4924.4 4439.8 4504.0 4508.4 4511.0 4513.9 4903.8 4930.3 4932.1 4937.4 4937.8 4637.4 4649.5 4658.0 4725.7 4737.1 4778.5 4795.6 4833.8 4836.6 4840.0 4742.3 4750.2 4757.3 4770.2 4805.5 4644.0 4726.1 4729.8 4743.2 4770.0 4123.8 4151.6 4153.0 4195.2 4213.0 3617.1 3645.9 3654.1 3673.6 3678.2 4126.4 4161.1 4176.8 4203.8 4209.8 4827.2 4849.7 4850.3 4855.5 4899.0 4194.3 4214.2 4222.5 4226.6 4253.0 4333.3 4340.0 4381.1 4412.0 4420.6 4567.4 4570.9 4581.2 4598.0 4604.8 4805.7 4806.8 4808.4 4823.5 4854.8 4529.8 4556.7 4573.7 4615.0 4621.5 4784.6 4787.0 4788.8 4790.1 4821.5 4826.0 4844.0 4849.8 4851.9 4901.2 4617.8 4653.8 4661.2 4712.4 4717.1 4694.4 4709.2 4714.9 4715.1 4720.8 4597.1 4616.5 4653.4 4657.2 4673.9 4774.8 4781.3 4786.7 4820.4 4820.9 4657.0 4664.4 4665.5 4669.9 4717.8 10:36:52 INFO - PROCESS | 20755 | 10:36:52 INFO - PROCESS | 20755 | [#1] ext.html Cycles:180 Average:44841.16 Median:19759.51 stddev:82275.13 (416.4%) stddev-sans-first:82438.79 10:36:52 INFO - PROCESS | 20755 | Values: 571.0 577.1 579.4 582.2 586.6 26682.9 27277.6 38867.0 39712.0 39882.0 39231.6 39710.4 39715.8 39719.0 39792.6 7768.4 7906.5 7911.1 7912.9 7915.6 7732.4 7815.7 7822.8 7823.8 7828.2 7834.2 7882.1 7884.5 7890.6 7893.5 7782.2 7794.5 7814.5 7819.6 7829.1 7771.3 7833.2 7842.5 7843.1 7843.5 38034.6 38142.2 38324.6 38331.2 38395.0 2861.9 3048.9 3051.6 3123.0 3418.7 28737.4 28814.1 28852.6 29170.1 29635.7 3460.6 3463.4 3483.9 3502.3 3592.9 250368.0 250704.0 250740.0 250963.7 251091.0 31604.8 48906.0 49466.0 49471.8 49572.3 31889.7 33516.3 33557.7 33632.2 33640.2 13092.4 13165.5 13174.7 13202.3 13224.7 10717.4 10802.2 10803.2 10832.7 10832.9 7737.6 7767.6 7788.1 7854.3 7865.8 3110.5 3126.9 3141.1 3161.2 3161.8 851.9 892.3 899.1 942.5 946.4 27377.3 27435.2 27664.6 27906.6 27960.9 943.2 967.1 996.3 997.3 1019.8 14308.4 14691.9 14703.7 14804.3 15026.6 371982.0 374566.0 376572.0 377539.1 377665.0 48365.0 48862.0 48977.0 49044.5 49076.0 1053.5 1153.3 1183.2 1199.9 1204.0 27722.0 28458.7 28676.4 29030.4 29311.7 35433.8 35487.3 35696.5 35701.5 35754.8 294398.0 297383.0 297986.0 297986.0 298851.0 22119.9 24261.8 24763.1 24882.4 25079.4 38743.4 38979.2 39858.4 40804.8 41657.2 36015.0 36133.6 36141.8 36503.8 36704.3 35926.1 36151.0 36289.6 36568.3 36683.3 35242.5 35686.3 35974.8 36174.3 36272.8 31569.8 32612.7 32677.8 32679.8 32734.2 24715.0 24808.6 25122.6 25272.4 25329.5 10:36:52 INFO - PROCESS | 20755 | 10:36:52 INFO - PROCESS | 20755 | [#2] jquery.html Cycles:180 Average:24665.96 Median:4428.08 stddev:59786.58 (1350.2%) stddev-sans-first:59926.38 10:36:52 INFO - PROCESS | 20755 | Values: 332.1 366.0 368.9 372.6 387.7 12950.5 16293.8 16893.5 17318.9 18277.7 16581.9 17319.8 17687.6 17691.4 17696.8 5142.5 6742.6 7125.3 7160.8 7178.9 4154.4 6654.7 6955.8 7056.6 7076.8 6901.7 7038.2 7151.6 7192.3 7193.2 7139.5 7174.9 7195.4 7198.2 7236.9 6694.9 6926.2 6929.9 6959.2 6961.0 23053.3 23289.0 23303.4 23406.9 24196.3 2038.6 2100.5 2133.0 2165.4 2221.6 14349.5 14766.3 14923.9 14934.7 14981.1 1873.7 1901.9 1912.8 1983.1 2004.5 80562.0 81649.0 82108.0 82462.6 83258.0 13841.9 14742.7 16022.7 16918.2 17141.5 10604.3 28869.6 28937.0 28995.0 29059.0 7003.7 7126.2 7135.2 7207.7 7211.2 6318.2 6353.6 6797.2 6849.0 7203.4 3782.1 3836.0 3867.1 3889.2 3909.1 1845.7 1854.6 1884.4 1892.7 1906.2 679.4 694.6 717.2 726.9 776.0 16200.3 16324.3 16350.6 16494.3 16776.7 694.2 737.8 744.5 752.5 785.3 8983.9 8987.6 9041.6 9044.3 9173.9 346192.0 361082.0 362626.0 362849.0 363485.0 78235.7 78321.6 78566.0 78746.0 78960.0 890.9 899.4 902.3 923.8 928.4 11860.2 15567.1 15652.5 15677.1 15984.4 38483.7 39358.0 39588.2 39702.0 40799.8 48960.0 49125.0 49339.0 49771.5 50133.2 4701.8 4817.3 6540.5 6578.2 7032.6 11487.0 11582.1 11655.9 11804.2 12043.9 9671.5 9757.2 10076.3 10244.4 10538.4 9443.4 9792.9 9936.2 9959.4 10329.3 8862.7 9562.1 9694.6 10574.5 10577.9 7264.5 7484.9 7490.9 7657.0 7756.5 9550.7 10034.4 10132.8 10225.7 10450.9 10:36:52 INFO - PROCESS | 20755 | 10:36:52 INFO - PROCESS | 20755 | [#3] mootools.html Cycles:180 Average:4927.44 Median:5334.52 stddev:2778.18 (52.1%) stddev-sans-first:2773.06 10:36:52 INFO - PROCESS | 20755 | Values: 1363.5 1411.4 1471.2 1654.4 1676.1 7287.0 7706.5 7776.5 7783.6 7788.7 6413.2 7034.2 7227.6 7240.7 7675.5 2136.0 2164.8 2166.2 2169.9 2170.5 1847.4 2159.5 2169.3 2199.7 2203.5 2060.3 2139.1 2142.6 2156.2 2162.7 2121.2 2126.7 2146.2 2185.2 2187.4 2111.1 2115.2 2118.7 2118.9 2120.8 7720.5 7742.3 7750.9 7753.8 7765.6 4418.7 4441.2 4501.0 4510.5 4527.0 2706.7 2801.2 2835.7 2844.0 2844.3 886.4 890.3 894.9 908.4 917.8 10195.5 10225.8 10239.5 10272.3 10276.2 3918.8 4099.4 4102.7 4113.7 4205.2 8749.5 8802.9 8821.9 8826.0 8853.2 4487.1 4489.7 4490.0 4492.8 4515.5 4015.1 4104.2 4109.3 4112.3 4120.7 3375.7 3452.5 3491.3 3515.2 3526.1 964.0 1028.3 1040.2 1041.9 1072.2 678.6 707.7 710.9 716.0 717.8 4754.0 4761.5 4871.2 4931.3 4939.7 783.2 794.4 801.8 841.5 868.7 3070.8 3200.2 3202.0 3202.2 3260.6 9222.5 9479.7 9581.7 9583.5 9598.0 8444.8 8866.3 9357.7 9482.5 9499.2 6861.2 7074.1 7095.2 7096.7 7102.4 5256.7 5289.1 5380.0 5463.1 5478.4 8402.1 8628.0 8697.6 8754.0 8784.3 8853.4 8868.9 8947.6 8996.9 9030.1 6171.1 6191.0 6227.8 6239.3 6255.1 7011.1 7011.8 7066.3 7111.5 7125.4 5507.7 5509.4 6228.9 6239.3 6387.9 5991.6 6095.8 6160.3 6198.9 6268.1 5960.7 5986.6 6015.1 6025.8 6026.8 4185.8 4214.3 4302.0 4305.6 4326.6 4171.5 4327.8 4420.6 4476.6 4489.6 10:36:52 INFO - PROCESS | 20755 | 10:36:52 INFO - PROCESS | 20755 | [#4] prototype.html Cycles:180 Average:4071.41 Median:4577.65 stddev:1171.82 (25.6%) stddev-sans-first:1140.23 10:36:52 INFO - PROCESS | 20755 | Values: 290.3 293.7 300.7 302.9 307.9 4693.5 4715.9 4733.7 4745.1 4767.4 4432.7 4441.8 4544.3 4648.0 4690.9 3711.8 3729.8 3730.3 3732.6 3744.8 3728.7 3752.3 3754.5 3771.4 3774.0 3558.6 3578.4 3720.8 3721.1 3731.4 3685.7 3692.0 3694.7 3706.7 3728.3 3295.9 3304.0 3304.9 3305.9 3312.6 4472.5 4558.7 4587.7 4593.7 4596.8 4234.9 4257.1 4261.7 4263.7 4265.6 4864.2 4871.6 4871.7 4879.4 4910.3 3619.8 3620.6 3623.5 3649.1 3649.1 4945.8 5083.1 5085.6 5112.9 5117.5 3679.9 3690.4 3690.8 3695.4 3709.8 3746.9 3748.9 3750.3 3758.3 3771.7 3927.2 4150.6 4209.0 4213.8 4232.5 4902.9 4913.5 4914.3 4917.8 4921.0 1193.4 1251.7 1255.2 1266.7 1305.8 886.3 900.3 920.3 920.8 921.6 3897.3 3906.6 3931.6 3932.8 3937.4 4448.5 4457.4 4469.5 4470.3 4489.3 3866.6 3895.0 3900.6 3901.2 3916.5 2381.7 2384.2 2484.5 2687.2 2692.0 4822.2 4838.9 4848.1 4862.5 4868.3 5192.5 5196.5 5201.7 5218.7 5236.9 4626.3 4823.3 4845.8 4858.9 4893.4 5046.0 5050.6 5061.9 5072.2 5100.1 4954.8 4973.2 4986.3 5002.4 5005.5 4616.2 4846.3 4878.5 4888.5 4891.7 3628.2 3642.7 3648.9 3656.8 3660.9 4858.4 5095.9 5099.5 5099.9 5116.2 4786.3 4942.8 4965.3 4972.6 4978.6 4925.8 4927.6 4928.1 4940.7 4946.0 4567.6 4875.9 4880.6 4887.1 4901.6 4911.3 4953.1 4966.5 4989.2 4991.5 4835.7 4840.7 4854.8 4879.8 4896.6 10:36:52 INFO - PROCESS | 20755 | 10:36:52 INFO - PROCESS | 20755 | [#5] yui.html Cycles:180 Average:17480.79 Median:498.64 stddev:25520.48 (5118.0%) stddev-sans-first:25560.47 10:36:52 INFO - PROCESS | 20755 | Values: 566.8 577.1 611.3 629.9 641.6 11722.7 12888.8 13456.3 13955.2 13988.4 13069.3 13132.1 13179.1 13243.1 13257.7 619.7 745.5 760.4 781.0 787.8 774.0 782.4 782.8 783.0 783.7 808.6 813.3 815.0 815.3 815.5 640.9 779.9 807.7 809.7 810.0 592.1 592.3 592.4 592.6 593.2 12827.8 12916.0 12940.7 12950.9 12972.9 11311.9 11685.5 11723.5 11746.2 11863.9 11046.0 11103.4 11141.8 11142.9 11158.7 4047.4 4074.8 4090.7 4096.9 4151.2 52726.0 55507.4 55575.2 64181.4 65295.3 9687.6 9942.3 9951.6 9983.8 10081.8 16923.6 17293.3 17555.5 17583.0 18218.5 6559.1 6599.3 6607.9 6623.7 6882.3 3730.2 3752.7 3817.9 3846.4 3892.7 2572.4 2690.7 2696.7 2698.1 2703.8 493.1 504.2 513.1 513.5 515.7 471.8 535.8 548.1 556.1 561.1 7933.4 8000.8 8083.3 8093.6 8253.6 535.5 538.2 548.1 558.2 563.2 3635.4 3873.6 3919.6 3938.0 4033.4 104538.5 105565.5 106439.5 110140.0 110504.0 79896.6 83447.6 83912.0 91036.0 93295.5 45545.9 57201.0 69146.7 69166.7 72725.3 8133.3 8206.3 8247.0 8520.7 8706.8 42625.1 43665.6 44288.3 44564.8 44801.8 55416.7 55417.2 58566.7 63699.4 64696.4 10661.6 10749.6 10898.7 11005.2 11014.0 12511.2 12517.7 12690.8 12847.2 13064.4 11210.7 11810.2 11857.6 11943.6 12308.9 10877.5 11230.5 11278.7 11679.2 11682.2 10948.9 11503.5 11845.2 11851.8 11860.8 9567.4 9629.2 9720.8 10056.2 10068.3 8973.4 9313.7 9575.0 9608.9 9769.1 10:36:52 INFO - PROCESS | 20755 | -------- Summary: end -------- 10:36:52 INFO - PROCESS | 20755 | 10:36:52 INFO - TEST-INFO | 20755: exit 0 10:36:52 INFO - TEST-OK | dromaeo_css | took 1119298ms 10:36:52 INFO - TEST-START | kraken 10:36:52 INFO - operating with platform_type : linux_ 10:36:52 INFO - Initialising browser for kraken test... 10:36:52 INFO - TEST-INFO | started process 20945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkDCBM9/profile http://localhost:42009/getInfo.html) 10:36:56 INFO - PROCESS | 20945 | __metrics Screen width/height:1600/1200 10:36:56 INFO - PROCESS | 20945 | colorDepth:24 10:36:56 INFO - PROCESS | 20945 | Browser inner width/height: 1024/697 10:36:56 INFO - PROCESS | 20945 | __metrics 10:36:57 INFO - PROCESS | 20945 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:36:57 INFO - PROCESS | 20945 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:36:58 INFO - TEST-INFO | 20945: exit 0 10:36:58 INFO - Browser initialized. 10:36:58 INFO - Running cycle 1/1 for kraken test... 10:36:58 INFO - TEST-INFO | started process 21028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkDCBM9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:37:10 INFO - PROCESS | 21028 | RSS: Main: 158613504 10:37:10 INFO - PROCESS | 21028 | 10:37:13 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42009/tests/kraken/driver.html?testName=audio-beat-detection) 10:37:14 INFO - PROCESS | 21028 | RSS: Main: 217280512 10:37:14 INFO - PROCESS | 21028 | 10:37:16 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42009/tests/kraken/driver.html?testName=audio-dft) 10:37:17 INFO - PROCESS | 21028 | RSS: Main: 203956224 10:37:17 INFO - PROCESS | 21028 | 10:37:20 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42009/tests/kraken/driver.html?testName=audio-fft) 10:37:21 INFO - PROCESS | 21028 | RSS: Main: 271904768 10:37:21 INFO - PROCESS | 21028 | 10:37:23 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42009/tests/kraken/driver.html?testName=audio-oscillator) 10:37:24 INFO - PROCESS | 21028 | RSS: Main: 181305344 10:37:24 INFO - PROCESS | 21028 | 10:37:26 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42009/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:37:27 INFO - PROCESS | 21028 | RSS: Main: 185679872 10:37:27 INFO - PROCESS | 21028 | 10:37:30 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42009/tests/kraken/driver.html?testName=imaging-darkroom) 10:37:30 INFO - PROCESS | 21028 | RSS: Main: 221859840 10:37:30 INFO - PROCESS | 21028 | 10:37:34 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42009/tests/kraken/driver.html?testName=imaging-desaturate) 10:37:35 INFO - PROCESS | 21028 | RSS: Main: 217391104 10:37:35 INFO - PROCESS | 21028 | 10:37:37 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42009/tests/kraken/driver.html?testName=json-parse-financial) 10:37:38 INFO - PROCESS | 21028 | RSS: Main: 219934720 10:37:38 INFO - PROCESS | 21028 | 10:37:40 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42009/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:37:40 INFO - PROCESS | 21028 | RSS: Main: 205938688 10:37:40 INFO - PROCESS | 21028 | 10:37:42 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42009/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:37:43 INFO - PROCESS | 21028 | RSS: Main: 209920000 10:37:43 INFO - PROCESS | 21028 | 10:37:45 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42009/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:37:46 INFO - PROCESS | 21028 | RSS: Main: 208838656 10:37:46 INFO - PROCESS | 21028 | 10:37:48 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:37:49 INFO - PROCESS | 21028 | RSS: Main: 222932992 10:37:49 INFO - PROCESS | 21028 | 10:37:52 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:37:53 INFO - PROCESS | 21028 | RSS: Main: 223072256 10:37:53 INFO - PROCESS | 21028 | 10:37:54 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:42009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42009/tests/kraken/driver.html?testName=ai-astar) 10:37:55 INFO - PROCESS | 21028 | RSS: Main: 265752576 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | __start_tp_report 10:37:55 INFO - PROCESS | 21028 | _x_x_mozilla_page_load 10:37:55 INFO - PROCESS | 21028 | _x_x_mozilla_page_load_details 10:37:55 INFO - PROCESS | 21028 | |i|pagename|runs| 10:37:55 INFO - PROCESS | 21028 | |0;ai-astar;108;115;115;113;115;114;114;115;114;115 10:37:55 INFO - PROCESS | 21028 | |1;audio-beat-detection;151;128;125;173;123;125;149;125;178;122 10:37:55 INFO - PROCESS | 21028 | |2;audio-dft;160;162;161;162;162;162;161;162;161;162 10:37:55 INFO - PROCESS | 21028 | |3;audio-fft;76;77;79;122;76;78;76;77;105;77 10:37:55 INFO - PROCESS | 21028 | |4;audio-oscillator;85;86;112;85;86;86;127;86;84;117 10:37:55 INFO - PROCESS | 21028 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;117 10:37:55 INFO - PROCESS | 21028 | |6;imaging-darkroom;147;147;147;147;146;146;147;147;146;146 10:37:55 INFO - PROCESS | 21028 | |7;imaging-desaturate;95;95;95;94;95;94;95;95;95;94 10:37:55 INFO - PROCESS | 21028 | |8;json-parse-financial;63;62;60;62;63;62;62;62;61;61 10:37:55 INFO - PROCESS | 21028 | |9;json-stringify-tinderbox;65;65;65;65;65;64;72;65;67;65 10:37:55 INFO - PROCESS | 21028 | |10;stanford-crypto-aes;79;80;79;78;79;79;79;84;78;89 10:37:55 INFO - PROCESS | 21028 | |11;stanford-crypto-ccm;131;132;139;139;147;129;131;141;169;129 10:37:55 INFO - PROCESS | 21028 | |12;stanford-crypto-pbkdf2;167;176;170;165;167;166;166;171;162;171 10:37:55 INFO - PROCESS | 21028 | |13;stanford-crypto-sha256-iterative;67;68;69;67;71;67;68;68;69;67 10:37:55 INFO - PROCESS | 21028 | __end_tp_report 10:37:55 INFO - PROCESS | 21028 | __start_cc_report 10:37:55 INFO - PROCESS | 21028 | _x_x_mozilla_cycle_collect,1901 10:37:55 INFO - PROCESS | 21028 | __end_cc_report 10:37:55 INFO - PROCESS | 21028 | __startTimestamp1468085875066__endTimestamp 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | ------- Summary: start ------- 10:37:55 INFO - PROCESS | 21028 | Number of tests: 14 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.00 stddev:2.15 (1.9%) stddev-sans-first:0.73 10:37:55 INFO - PROCESS | 21028 | Values: 108.0 115.0 115.0 113.0 115.0 114.0 114.0 115.0 114.0 115.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:138.50 stddev:21.52 (15.5%) stddev-sans-first:22.44 10:37:55 INFO - PROCESS | 21028 | Values: 151.0 128.0 125.0 173.0 123.0 125.0 149.0 125.0 178.0 122.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.71 (0.4%) stddev-sans-first:0.50 10:37:55 INFO - PROCESS | 21028 | Values: 160.0 162.0 161.0 162.0 162.0 162.0 161.0 162.0 161.0 162.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#3] audio-fft Cycles:10 Average:84.30 Median:77.00 stddev:15.93 (20.7%) stddev-sans-first:16.61 10:37:55 INFO - PROCESS | 21028 | Values: 76.0 77.0 79.0 122.0 76.0 78.0 76.0 77.0 105.0 77.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.50 stddev:16.47 (19.3%) stddev-sans-first:17.03 10:37:55 INFO - PROCESS | 21028 | Values: 85.0 86.0 112.0 85.0 86.0 86.0 127.0 86.0 84.0 117.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:37:55 INFO - PROCESS | 21028 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:37:55 INFO - PROCESS | 21028 | Values: 147.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:37:55 INFO - PROCESS | 21028 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 10:37:55 INFO - PROCESS | 21028 | Values: 63.0 62.0 60.0 62.0 63.0 62.0 62.0 62.0 61.0 61.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:65.00 stddev:2.30 (3.5%) stddev-sans-first:2.42 10:37:55 INFO - PROCESS | 21028 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 72.0 65.0 67.0 65.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.00 stddev:3.47 (4.4%) stddev-sans-first:3.64 10:37:55 INFO - PROCESS | 21028 | Values: 79.0 80.0 79.0 78.0 79.0 79.0 79.0 84.0 78.0 89.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:139.00 stddev:12.22 (8.8%) stddev-sans-first:12.64 10:37:55 INFO - PROCESS | 21028 | Values: 131.0 132.0 139.0 139.0 147.0 129.0 131.0 141.0 169.0 129.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.50 stddev:3.96 (2.3%) stddev-sans-first:4.18 10:37:55 INFO - PROCESS | 21028 | Values: 167.0 176.0 170.0 165.0 167.0 166.0 166.0 171.0 162.0 171.0 10:37:55 INFO - PROCESS | 21028 | 10:37:55 INFO - PROCESS | 21028 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.29 (1.9%) stddev-sans-first:1.30 10:37:55 INFO - PROCESS | 21028 | Values: 67.0 68.0 69.0 67.0 71.0 67.0 68.0 68.0 69.0 67.0 10:37:55 INFO - PROCESS | 21028 | -------- Summary: end -------- 10:37:55 INFO - PROCESS | 21028 | 10:37:56 INFO - TEST-INFO | 21028: exit 0 10:37:56 INFO - TEST-OK | kraken | took 63320ms 10:37:56 INFO - SUITE-END | took 1182s 10:37:56 INFO - Completed test suite (00:19:42) 10:37:56 INFO - javascript benchmark 10:37:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2533.5312967101086, 2533.708623508297, 2575.7424257574244, 2580.1614475295523, 2584.728603496633, 4423.911521769563, 4480.171168333853, 4524.389207456992, 4573.679842411033, 4575.062112266982, 4500.639948804096, 4517.909641807162, 4521.638268938485, 4575.359449677047, 4594.609458196057, 3942.152437225996, 4111.0544574747755, 4174.0, 4204.11713540157, 4318.805653745589, 4221.071364299849, 4291.163223171483, 4292.935605965898, 4295.742255464682, 4333.393324934512, 4131.215069136884, 4146.668266538685, 4167.1040726244, 4196.139791342767, 4215.557366476506, 4130.318497447917, 4197.160567886435, 4208.600182982612, 4218.578142185787, 4251.489821221442, 4160.167966406731, 4161.958380416218, 4184.267753143218, 4193.245215861144, 4196.202721482909, 4455.242608756519, 4503.774811259456, 4557.453105627313, 4612.95387046132, 4623.653226008063, 4869.0, 4881.658283920127, 4893.828715994959, 4910.386201724785, 4918.778654960535, 4698.741569213692, 4714.057188562301, 4882.560569548722, 4901.632377571696, 4924.43369012561, 4439.7780110994645, 4503.986603014296, 4508.413906192174, 4510.954890451119, 4513.864584062483, 4903.754812259373, 4930.334404855299, 4932.062908047531, 4937.382827146606, 4937.7777999990085, 4637.397138372057, 4649.5350464953235, 4658.0, 4725.692829966041, 4737.123632128068, 4778.474367819537, 4795.568398844121, 4833.830815921426, 4836.5888899443235, 4839.951600484021, 4742.312364707167, 4750.216214324598, 4757.333973243749, 4770.236762118045, 4805.543473370024, 4644.001539668988, 4726.125666751662, 4729.787159577827, 4743.193657078305, 4769.998300356964, 4123.793810309473, 4151.605597468236, 4153.044799696087, 4195.223883581547, 4213.0, 3617.0595645132457, 3645.872394466234, 3654.1230104775195, 3673.577538583044, 3678.2459595782802, 4126.42230087788, 4161.10536234711, 4176.812043458051, 4203.789810509462, 4209.831606735696, 4827.179379505493, 4849.733264670477, 4850.345203397496, 4855.465898751135, 4899.044686286211, 4194.266003449384, 4214.220369231702, 4222.451081359403, 4226.556211597799, 4253.043065310342, 4333.349997500401, 4340.0, 4381.123775244963, 4411.985243394038, 4420.646348292129, 4567.38340324052, 4570.88572785683, 4581.198290299118, 4597.977010114928, 4604.815807367668, 4805.711657300573, 4806.831760888352, 4808.422989241313, 4823.517648235148, 4854.75726213695, 4529.796159172779, 4556.703814252063, 4573.702709323883, 4615.030843522898, 4621.491635920113, 4784.617230621611, 4787.018661174381, 4788.832390866303, 4790.137775200497, 4821.493743156918, 4825.9758701206265, 4843.951560484491, 4849.830255941025, 4851.927221091757, 4901.215805471107, 4617.769111544477, 4653.837115700934, 4661.160991021648, 4712.434507859079, 4717.103750287434, 4694.413198350207, 4709.222978208694, 4714.929276060793, 4715.104130215248, 4720.787564559534, 4597.149527337453, 4616.49218585962, 4653.395058642355, 4657.184992626209, 4673.883152921204, 4774.809007639795, 4781.330613714153, 4786.688865223749, 4820.39745031871, 4820.903581928272, 4657.022025374709, 4664.440267167826, 4665.48679645232, 4669.929951050805, 4717.811287548459], "value": 4453.072291361125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.997145014275, 577.0939624789078, 579.4437340153453, 582.1965687351452, 586.609904413565, 26682.86658566707, 27277.59083613745, 38867.02832429191, 39712.014399280066, 39882.0, 39231.607683923154, 39710.40434393486, 39715.80142099285, 39719.0, 39792.60207397925, 7768.417368697356, 7906.486078404914, 7911.050673919138, 7912.920870791305, 7915.6042197890165, 7732.381409487228, 7815.687372505093, 7822.843543129134, 7823.843523129534, 7828.217178282155, 7834.216578342149, 7882.054153501588, 7884.526928384286, 7890.56601886896, 7893.526388416684, 7782.18287079857, 7794.532328060278, 7814.452988290822, 7819.64811583483, 7829.060512738451, 7771.339436147934, 7833.177516360757, 7842.490238134503, 7843.137254901956, 7843.450958432912, 38034.619653803384, 38142.23715525702, 38324.616753832386, 38331.23337533234, 38395.0, 2861.948660613997, 3048.923776905573, 3051.6032915721034, 3123.047470521513, 3418.67522585354, 28737.42525149506, 28814.135575932756, 28852.567211491845, 29170.124896253146, 29635.703642963508, 3460.636633153533, 3463.428534291839, 3483.9129021774406, 3502.317048175607, 3592.892213233581, 250368.0, 250704.0, 250740.0, 250963.74518127475, 251091.0, 31604.841975789976, 48906.0, 49466.0, 49471.78433401817, 49572.25641615379, 31889.681103189134, 33516.3296734064, 33557.66442335594, 33632.15919602029, 33640.1589960253, 13092.410841512155, 13165.53920612774, 13174.670633234055, 13202.273874936971, 13224.669383265495, 10717.356958582353, 10802.189835762192, 10803.243772935819, 10832.67501974942, 10832.945835270773, 7737.613119344122, 7767.572783496849, 7788.14330423653, 7854.332381747501, 7865.842683146305, 3110.4712198926236, 3126.89055883043, 3141.0733833519166, 3161.1780936956097, 3161.7944833585743, 851.8849955256085, 892.3173772064376, 899.1368286444955, 942.4675058591873, 946.3895787217207, 27377.31556711058, 27435.17694469169, 27664.58503122455, 27906.581401278996, 27960.86019569889, 943.2077055273603, 967.1150896929231, 996.342414006752, 997.3417544420647, 1019.8011387779312, 14308.356123974447, 14691.85308146905, 14703.705925881422, 14804.333804978802, 15026.624334391729, 371982.0, 374566.0, 376572.0, 377539.11230443674, 377665.0, 48365.0, 48862.0, 48977.0, 49044.50955490399, 49076.018479630206, 1053.4627340056472, 1153.2734377342222, 1183.230899915062, 1199.9280043197436, 1204.0488014468472, 27722.0, 28458.715412845606, 28676.42647147087, 29030.41939161247, 29311.7068829309, 35433.82283088568, 35487.290254195286, 35696.464553031205, 35701.46447803337, 35754.821225894746, 294398.0, 297383.0, 297986.0, 297986.0, 298851.0, 22119.889400552893, 24261.757382426655, 24763.13329033475, 24882.377940551632, 25079.373015674755, 38743.41884871673, 38979.2204155921, 39858.402123967586, 40804.79597601993, 41657.1668566633, 36015.0, 36133.63866361303, 36141.819290903375, 36503.817480912425, 36704.26591468209, 35926.12095259825, 36151.0, 36289.63710362863, 36568.26863462769, 36683.266334672626, 35242.47136293009, 35686.28627427489, 35974.82012590025, 36174.27651447009, 36272.81863590665, 31569.8421507891, 32612.673873260963, 32677.836610816794, 32679.836600816845, 32734.181645459055, 24715.0, 24808.627870582317, 25122.623160652238, 25272.36819079464, 25329.49341013206], "value": 16175.274333683552, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.0536471057485, 366.0, 368.86167687117324, 372.6348178784791, 387.7053439386066, 12950.54673086441, 16293.83706162938, 16893.493195204162, 17318.913405432955, 18277.725834112465, 16581.91709041456, 17319.82680173198, 17687.646247075052, 17691.380801671945, 17696.82303176971, 5142.460041695615, 6742.629155396451, 7125.3230943060325, 7160.785176444715, 7178.892316615229, 4154.376843473473, 6654.733810647593, 6955.791326260221, 7056.611886346249, 7076.752313668997, 6901.723931042752, 7038.15542134942, 7151.642417879111, 7192.31672991065, 7193.172785129698, 7139.535930164523, 7174.928250717504, 7195.352418282379, 7198.172210195816, 7236.8552628947655, 6694.93305066948, 6926.168859736814, 6929.930700693029, 6959.164900211957, 6960.965195173992, 23053.308400747836, 23289.0, 23303.417414564603, 23406.882965585235, 24196.274111776675, 2038.5718999010226, 2100.506381000479, 2133.0294715904224, 2165.4261620670536, 2221.6445368741083, 14349.497767578085, 14766.26168691572, 14923.858877826035, 14934.701305973927, 14981.101133932, 1873.7376767252595, 1901.9239230430906, 1912.7800302965197, 1983.1274239334791, 2004.5189154602936, 80562.0, 81649.0, 82108.0, 82462.58768706178, 83258.0, 13841.930790345983, 14742.673159415705, 16022.679546409006, 16918.238679259215, 17141.48575542736, 10604.310719803343, 28869.56695649567, 28937.0, 28995.0, 29059.0, 7003.684834182474, 7126.216116227314, 7135.179454362711, 7207.675654595556, 7211.242819503981, 6318.178636777189, 6353.555251132469, 6797.218319893177, 6849.04113424121, 7203.423726102004, 3782.1467480934143, 3835.9808200959374, 3867.0719027433774, 3889.202713443794, 3909.081365879016, 1845.7323688065155, 1854.573448106943, 1884.406411980222, 1892.6782446984046, 1906.170815695177, 679.4055201698513, 694.6075467361026, 717.1573401253506, 726.9491135620456, 776.0338378718532, 16200.270987805578, 16324.347026118823, 16350.591235219215, 16494.2577584009, 16776.748348774778, 694.2432748304373, 737.8339873528413, 744.5346658338539, 752.450710980987, 785.3299572717252, 8983.865242021375, 8987.55062246885, 9041.63833446668, 9044.276457883354, 9173.862392064124, 346192.0, 361082.0, 362626.0, 362849.0, 363485.0, 78235.74114070974, 78321.60839195881, 78566.0, 78746.0, 78960.0, 890.9153630404971, 899.4153800030033, 902.3232575568323, 923.8337099322052, 928.4058202750246, 11860.19347689378, 15567.143807090266, 15652.530424087296, 15677.137757423452, 15984.360625575311, 38483.73089048824, 39358.0, 39588.20823583454, 39702.0, 40799.79600102099, 48960.0, 49125.0, 49339.0, 49771.50228497669, 50133.24800127928, 4701.788419521198, 4817.325574419514, 6540.542162048611, 6578.210614726264, 7032.593481303657, 11487.0, 11582.131340149692, 11655.941720291345, 11804.173707840711, 12043.879561204276, 9671.468069256258, 9757.219422446045, 10076.294659374067, 10244.385336879812, 10538.367697938149, 9443.433393996382, 9792.85310720354, 9936.155426788804, 9959.352642078242, 10329.32859364169, 8862.734117976472, 9562.091601297865, 9694.6122155113, 10574.471276436301, 10577.9471102644, 7264.455165862687, 7484.850302994018, 7490.887636685345, 7657.042869641295, 7756.534607923542, 9550.665726699532, 10034.448105354275, 10132.848007279748, 10225.744356390853, 10450.947745261225], "value": 8738.891119314352, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.481876886783, 1411.4354258296682, 1471.168395347792, 1654.3878764857004, 1676.0530300380285, 7286.963565182174, 7706.460547761659, 7776.53340799551, 7783.64973576189, 7788.6884524618945, 6413.198350206224, 7034.15590129184, 7227.566346019243, 7240.710371585144, 7675.462717609769, 2135.9679604805942, 2164.7943445372744, 2166.2309879992613, 2169.913203471859, 2170.5007848194846, 1847.3718935561906, 2159.5249045210107, 2169.3166652504488, 2199.714037175173, 2203.526241858, 2060.2994981706215, 2139.101577337522, 2142.5607750411205, 2156.1590979518, 2162.697222388867, 2121.1727426303755, 2126.7022616833656, 2146.152269853415, 2185.2133232036454, 2187.4203336115784, 2111.102781317949, 2115.1645100185497, 2118.66101423773, 2118.8622739521884, 2120.8091271785615, 7720.459567830254, 7742.264484873928, 7750.883736743954, 7753.806154846117, 7765.611719414063, 4418.668599854992, 4441.244988351988, 4500.977495112536, 4510.481294651125, 4527.0, 2706.6751989761356, 2801.229661842989, 2835.744782969522, 2844.033028770228, 2844.33158207821, 886.3529623374908, 890.3322508118911, 894.9463032218023, 908.4413085952092, 917.7797328641145, 10195.541200645914, 10225.795484090351, 10239.48802559869, 10272.332298400655, 10276.229282803744, 3918.804059796999, 4099.426080348753, 4102.733322334038, 4113.670906327487, 4205.17998990194, 8749.518776467228, 8802.86795698065, 8821.911780882108, 8825.955870220736, 8853.247473964657, 4487.057717879282, 4489.708168969007, 4489.9775501122285, 4492.752898590609, 4515.503294637587, 4015.13674559971, 4104.220198162339, 4109.260333140063, 4112.259793237246, 4120.7321524100835, 3375.696187343151, 3452.5166476693284, 3491.266833964896, 3515.2442224921765, 3526.1360966563357, 964.0, 1028.2596530498179, 1040.2354269611828, 1041.8958104189521, 1072.158355690779, 678.6097993653669, 707.678006507038, 710.886258198696, 715.9606221657755, 717.8348979734691, 4753.953736424179, 4761.452432970253, 4871.244957031666, 4931.334269873593, 4939.654224204343, 783.1815752538611, 794.3803833010261, 801.8155824160359, 841.5329492131925, 868.7306934850217, 3070.78504504687, 3200.1839530919465, 3201.9679803202134, 3202.167436466489, 3260.6087269527807, 9222.53887305632, 9479.715608531755, 9581.712548623413, 9583.472908990072, 9598.0, 8444.831103377897, 8866.33502487316, 9357.672481463116, 9482.525873706425, 9499.192568631745, 6861.210960739579, 7074.080369552028, 7095.219525852152, 7096.680649370791, 7102.4318054555515, 5256.658317209369, 5289.074411977812, 5379.973100134631, 5463.07127788269, 5478.369987451494, 8402.11777763326, 8628.0, 8697.6086076128, 8753.956230218808, 8784.297256219616, 8853.38026338176, 8868.911310887066, 8947.552622368725, 8996.910030899608, 9030.096990300917, 6171.105189747551, 6190.969045154926, 6227.750889964351, 6239.282482514569, 6255.093011513214, 7011.053507776589, 7011.754588589375, 7066.258042905626, 7111.502194846311, 7125.35871771543, 5507.669539827623, 5509.393966663744, 6228.906566401417, 6239.251289845248, 6387.936120638734, 5991.621294465082, 6095.756169753337, 6160.291566469913, 6198.907016394848, 6268.091126786681, 5960.731767070405, 5986.610870293417, 6015.097735339734, 6025.8192254232445, 6026.819195424145, 4185.790710464526, 4214.325707886724, 4301.978490107529, 4305.634021108241, 4326.58897404746, 4171.499420069611, 4327.778274652401, 4420.58004489573, 4476.552344765498, 4489.573490518395], "value": 3957.3951490343593, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.3018241130083, 293.7048266492175, 300.6542476152425, 302.92426893276684, 307.86761692472226, 4693.460252071013, 4715.90568188636, 4733.739644319561, 4745.122152401804, 4767.404074490689, 4432.734035957845, 4441.800118994645, 4544.295634176699, 4647.953520464795, 4690.859274221771, 3711.8144092795387, 3729.7762134271893, 3730.2912446635187, 3732.5894151643433, 3744.794036328001, 3728.6949567651377, 3752.2683076800035, 3754.49314342563, 3771.41543060826, 3773.9622603773887, 3558.626344233857, 3578.3916734155255, 3720.8325625346924, 3721.1069343357535, 3731.365667836474, 3685.7051435885332, 3691.963080369189, 3694.685951694109, 3706.7405281630295, 3728.291624591319, 3295.9011229663147, 3303.966960330414, 3304.9424184261047, 3305.8512366943546, 3312.635610082889, 4472.485664148599, 4558.680892337537, 4587.72473651582, 4593.724376537419, 4596.816127354902, 4234.872953811359, 4257.106007738348, 4261.659067274611, 4263.744175349489, 4265.552117027699, 4864.246041863482, 4871.56155945963, 4871.683340582851, 4879.438864530589, 4910.263460480921, 3619.7647152934974, 3620.5655321361605, 3623.4927110204594, 3649.069487280753, 3649.1424515238896, 4945.752712364368, 5083.135866902636, 5085.593152547787, 5112.872178195537, 5117.513836185556, 3679.9264014720093, 3690.446433035066, 3690.760100593453, 3695.371786796251, 3709.8330575124182, 3746.9063273417837, 3748.887533374003, 3750.2686976039954, 3758.2671379080816, 3771.660550550409, 3927.19492504036, 4150.584941505886, 4208.9789551052045, 4213.789310534461, 4232.534421213664, 4902.921357301388, 4913.459519452857, 4914.336564563738, 4917.754112294371, 4920.975395123001, 1193.433119268358, 1251.6620512461584, 1255.2029461292145, 1266.6643339515035, 1305.8171855940177, 886.2511178054533, 900.2977677411629, 920.2729843423621, 920.7559996600907, 921.5944984206927, 3897.2595206910596, 3906.628870257321, 3931.623931623909, 3932.7583277532103, 3937.42907278443, 4448.532904045093, 4457.375967364572, 4469.463664360298, 4470.262406702923, 4489.349044388546, 3866.5940076292145, 3894.9610503895165, 3900.620621420931, 3901.205445495047, 3916.4712763776524, 2381.72610149835, 2384.225126833786, 2484.5403600334, 2687.1535466328046, 2691.9596206056926, 4822.156122678517, 4838.927416088762, 4848.0788650156355, 4862.5380588844, 4868.269759536027, 5192.480751924777, 5196.506331898464, 5201.661891977009, 5218.686878787209, 5236.895262094737, 4626.282926146453, 4823.300621409946, 4845.781939812717, 4858.878528036827, 4893.437254715682, 5045.974770126126, 5050.621203409685, 5061.9493805061475, 5072.21028434367, 5100.132977393778, 4954.826581069645, 4973.204287314013, 4986.3295795907325, 5002.424721156968, 5005.473330634191, 4616.192166370939, 4846.297286893451, 4878.487758785276, 4888.462269150462, 4891.682040667345, 3628.2380700053286, 3642.6721595056574, 3648.854045838243, 3656.762310449812, 3660.865131809148, 4858.368412106403, 5095.898082038412, 5099.5410413063, 5099.949000510096, 5116.155834287301, 4786.305985631994, 4942.802287908444, 4965.329680493087, 4972.552470277692, 4978.576820970258, 4925.778339974781, 4927.556519913225, 4928.137575924127, 4940.7035577865445, 4945.975270123627, 4567.566081222279, 4875.878103047452, 4880.560234730692, 4887.095887260868, 4901.558859702502, 4911.263310503453, 4953.083679519301, 4966.528179822911, 4989.201727723546, 4991.450940396626, 4835.734034628129, 4840.7337596432535, 4854.83008094715, 4879.80480780779, 4896.583790377857], "value": 3706.3904671727637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.8299510146957, 577.0853197681674, 611.3313218560809, 629.9055141728743, 641.5797652537586, 11722.706932326697, 12888.806667899977, 13456.327183640828, 13955.232462214573, 13988.440462381517, 13069.346532673377, 13132.080754347176, 13179.143355681874, 13243.072984891038, 13257.734845303088, 619.6870580356914, 745.4930647159929, 760.3992845651942, 781.0315209140681, 787.7991112266365, 773.97678069658, 782.4444644302523, 782.7769085810545, 782.9804254893617, 783.6669415498419, 808.6037841457672, 813.2802469814197, 814.9959250203741, 815.3151352863594, 815.5392203405087, 640.932702066281, 779.949303295284, 807.7132617920671, 809.7489778168787, 810.0, 592.1354821959943, 592.2744637818681, 592.4460629311608, 592.602956019468, 593.2139914613155, 12827.807582886264, 12916.0, 12940.741185176337, 12950.935245323808, 12972.935135324356, 11311.886881131166, 11685.532578696842, 11723.531058757639, 11746.236494627821, 11863.940680296544, 11046.0, 11103.44482775858, 11141.832872506919, 11142.944285278603, 11158.665240042812, 4047.402733544304, 4074.7555146691293, 4090.7396824607927, 4096.938545921814, 4151.232022075926, 52726.0, 55507.44492555063, 55575.16637250444, 64181.358186418474, 65295.3470465294, 9687.564059617334, 9942.254330925209, 9951.601935922483, 9983.750406239757, 10081.798364032826, 16923.57691057709, 17293.308267669152, 17555.473335799947, 17583.0, 18218.54453638643, 6559.147310849559, 6599.307072757388, 6607.900881486686, 6623.735050597922, 6882.346177113266, 3730.235301763132, 3752.6622603965775, 3817.923641527154, 3846.3653497172654, 3892.6691231245095, 2572.4469239113305, 2690.704022557517, 2696.7303269672875, 2698.123109989261, 2703.8242514236513, 493.0779442442655, 504.20587574569464, 513.1302442360238, 513.5095983335905, 515.7498613172609, 471.8466498387969, 535.788363596385, 548.101114172757, 556.1490918894018, 561.0630247486707, 7933.365330773524, 8000.799980000546, 8083.272505474418, 8093.595320233965, 8253.566019619328, 535.5207089654738, 538.2491424462852, 548.1175307754512, 558.1961974756338, 563.2171281918137, 3635.4365073413665, 3873.573906870242, 3919.627635374635, 3937.9606203938165, 4033.415154802537, 104538.47730761298, 105565.47217263865, 106439.46780266204, 110140.0, 110504.0, 79896.60051699704, 83447.5827620858, 83912.0, 91036.0, 93295.53352233196, 45545.861353466425, 57201.0, 69146.65426672835, 69166.65416672884, 72725.2727472729, 8133.349332053303, 8206.302464290602, 8246.958765206136, 8520.74437766868, 8706.825863482569, 42625.14749705051, 43665.56334436615, 44288.33567496554, 44564.77717611521, 44801.77599112114, 55416.72291638516, 55417.1687424697, 58566.707166465596, 63699.36300636934, 64696.353036470915, 10661.57353705874, 10749.570017199225, 10898.727531811768, 11005.229633925548, 11014.0, 12511.186772859735, 12517.749645006867, 12690.809637855624, 12847.229166250056, 13064.412101455267, 11210.66368008961, 11810.173287869766, 11857.5849845255, 11943.641690749291, 12308.938455307667, 10877.456127193767, 11230.494627741607, 11278.718032049264, 11679.240849344766, 11682.24065435744, 10948.945255273673, 11503.48234329474, 11845.170838041598, 11851.822222666839, 11860.762784744084, 9567.37812042215, 9629.181519570635, 9720.805583888141, 10056.245781566558, 10068.295219334575, 8973.416727912665, 9313.674021409219, 9574.952125239608, 9608.9039109608, 9769.071938165864], "value": 6435.244698757049, "unit": "score"}], "name": "dromaeo_css", "value": 6246.797833493392, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 115.0, 113.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 125.0, 173.0, 123.0, 125.0, 149.0, 125.0, 178.0, 122.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 122.0, 76.0, 78.0, 76.0, 77.0, 105.0, 77.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 112.0, 85.0, 86.0, 86.0, 127.0, 86.0, 84.0, 117.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 60.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 72.0, 65.0, 67.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 78.0, 79.0, 79.0, 79.0, 84.0, 78.0, 89.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 139.0, 139.0, 147.0, 129.0, 131.0, 141.0, 169.0, 129.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 176.0, 170.0, 165.0, 167.0, 166.0, 166.0, 171.0, 162.0, 171.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 71.0, 67.0, 68.0, 68.0, 69.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1536.2, "alertThreshold": 2.0}]} 10:37:56 INFO - Return code: 0 10:37:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:37:56 INFO - # TBPL SUCCESS # 10:37:56 INFO - Running post-action listener: _resource_record_post_action 10:37:56 INFO - ##### 10:37:56 INFO - ##### Finished run-tests step (success) 10:37:56 INFO - ##### 10:37:56 INFO - Running post-run listener: _resource_record_post_run 10:37:56 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534908928; Read time: 16; Write time: 393128 10:37:56 INFO - TinderboxPrint: CPU usage
13.0% 10:37:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:37:56 INFO - TinderboxPrint: I/O write bytes / time
534,908,928 / 393,128 10:37:56 INFO - TinderboxPrint: CPU idle
8,328.4 (87.0%) 10:37:56 INFO - TinderboxPrint: CPU user
1,201.2 (12.6%) 10:37:56 INFO - TinderboxPrint: Swap in / out
0 / 0 10:37:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245977088; Read time: 0; Write time: 216168 10:37:56 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288321536; Read time: 0; Write time: 176960 10:37:57 INFO - Running post-run listener: _upload_blobber_files 10:37:57 INFO - Blob upload gear active. 10:37:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:37:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:37:57 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:37:57 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:37:57 INFO - (blobuploader) - INFO - Open directory for files ... 10:37:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:37:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:37:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:58 INFO - (blobuploader) - INFO - Done attempting. 10:37:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:37:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:38:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:01 INFO - (blobuploader) - INFO - Done attempting. 10:38:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:38:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:38:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:01 INFO - (blobuploader) - INFO - Done attempting. 10:38:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:38:02 INFO - Return code: 0 10:38:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:38:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:38:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71ed1ec71cb35db0c07afde38c726f01d84f5c89d74346cf046d4ff8549b3030505833e0111bed257050ef32106414fb7d91af03bb18a0cc8cf616db2743efe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fce5547abf10579e4ffb6086516b77746fb850201b16b5b62d1053f2537bdbce6fee42277c060945ec3abce3539b5ad8357d3796da0215da82f05d4e74c40f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43893e32ff081fee24865b9e4127ca9d8fdefdb43b597576c0e043869bdb869e807003f2a722d4bbadbc4871e6d047019bcde76804daf1efae4048e5b5de28a5"} 10:38:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:38:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:38:02 INFO - Contents: 10:38:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71ed1ec71cb35db0c07afde38c726f01d84f5c89d74346cf046d4ff8549b3030505833e0111bed257050ef32106414fb7d91af03bb18a0cc8cf616db2743efe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fce5547abf10579e4ffb6086516b77746fb850201b16b5b62d1053f2537bdbce6fee42277c060945ec3abce3539b5ad8357d3796da0215da82f05d4e74c40f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43893e32ff081fee24865b9e4127ca9d8fdefdb43b597576c0e043869bdb869e807003f2a722d4bbadbc4871e6d047019bcde76804daf1efae4048e5b5de28a5"} 10:38:02 INFO - Running post-run listener: copy_logs_to_upload_dir 10:38:02 INFO - Copying logs to upload dir... 10:38:02 INFO - mkdir: /builds/slave/test/build/upload/logs 10:38:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.421149 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-09 10:38:01.096853) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 10:38:01.100751) ========= 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=6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71ed1ec71cb35db0c07afde38c726f01d84f5c89d74346cf046d4ff8549b3030505833e0111bed257050ef32106414fb7d91af03bb18a0cc8cf616db2743efe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fce5547abf10579e4ffb6086516b77746fb850201b16b5b62d1053f2537bdbce6fee42277c060945ec3abce3539b5ad8357d3796da0215da82f05d4e74c40f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43893e32ff081fee24865b9e4127ca9d8fdefdb43b597576c0e043869bdb869e807003f2a722d4bbadbc4871e6d047019bcde76804daf1efae4048e5b5de28a5"} build_url:https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/TIO6SHgKQOGtp-0Q1uPCdg/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/Firefox-Non-PGO/sha512/71ed1ec71cb35db0c07afde38c726f01d84f5c89d74346cf046d4ff8549b3030505833e0111bed257050ef32106414fb7d91af03bb18a0cc8cf616db2743efe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fce5547abf10579e4ffb6086516b77746fb850201b16b5b62d1053f2537bdbce6fee42277c060945ec3abce3539b5ad8357d3796da0215da82f05d4e74c40f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43893e32ff081fee24865b9e4127ca9d8fdefdb43b597576c0e043869bdb869e807003f2a722d4bbadbc4871e6d047019bcde76804daf1efae4048e5b5de28a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 10:38:01.126912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 10:38:01.127344) ========= 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=6dbc10da6d83fee962c624be000001a8-1468075618.877395-1243105483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 10:38:01.210614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 10:38:01.211002) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 10:38:01.211353) ========= ========= Total master_lag: 0.17 =========