builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1467326605.42 results: success (0) buildid: 20160630123004 builduid: 24431ea62254404cb3012890ef335693 revision: 2f3a0b0aab552654bd8bc2bbfe84c8ec24023ae1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:25.419131) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:25.419607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:25.419899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:25.434766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:25.435133) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 15:43:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.5M=0s 2016-06-30 15:43:26 (60.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095611 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:25.545448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:25.545775) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018177 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:25.595757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:25.596105) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2f3a0b0aab552654bd8bc2bbfe84c8ec24023ae1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 2f3a0b0aab552654bd8bc2bbfe84c8ec24023ae1 --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=74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 15:43:26,205 truncating revision to first 12 chars 2016-06-30 15:43:26,205 Setting DEBUG logging. 2016-06-30 15:43:26,205 attempt 1/10 2016-06-30 15:43:26,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2f3a0b0aab55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 15:43:26,492 unpacking tar archive at: autoland-2f3a0b0aab55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615379 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:26.225396) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:26.225735) ========= script_repo_revision: 2f3a0b0aab552654bd8bc2bbfe84c8ec24023ae1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:26.226125) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:26.226388) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 15:43:26.237962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-30 15:43:26.238382) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:43:26 INFO - MultiFileLogger online at 20160630 15:43:26 in /builds/slave/test 15:43:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:43:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:43:26 INFO - {'append_to_log': False, 15:43:26 INFO - 'base_work_dir': '/builds/slave/test', 15:43:26 INFO - 'blob_upload_branch': 'Autoland', 15:43:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:43:26 INFO - 'branch': 'Autoland', 15:43:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:43:26 INFO - 'config_files': ('talos/linux_config.py',), 15:43:26 INFO - 'default_actions': ('clobber', 15:43:26 INFO - 'read-buildbot-config', 15:43:26 INFO - 'download-and-extract', 15:43:26 INFO - 'populate-webroot', 15:43:26 INFO - 'create-virtualenv', 15:43:26 INFO - 'install', 15:43:26 INFO - 'run-tests'), 15:43:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:43:26 INFO - 'download_minidump_stackwalk': True, 15:43:26 INFO - 'download_symbols': 'ondemand', 15:43:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:43:26 INFO - 'tooltool.py': '/tools/tooltool.py', 15:43:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:43:26 INFO - '/tools/misc-python/virtualenv.py')}, 15:43:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:43:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:43:26 INFO - 'installer_path': 'installer.exe', 15:43:26 INFO - 'log_level': 'info', 15:43:26 INFO - 'log_name': 'talos', 15:43:26 INFO - 'log_to_console': True, 15:43:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:43:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:43:26 INFO - 'opt_config_files': (), 15:43:26 INFO - 'pip_index': False, 15:43:26 INFO - 'sps_profile': False, 15:43:26 INFO - 'sps_profile_interval': 0, 15:43:26 INFO - 'suite': 'dromaeojs', 15:43:26 INFO - 'system_bits': '32', 15:43:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:43:26 INFO - 'title': 'talos-linux64-ix-042', 15:43:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:43:26 INFO - 'use_talos_json': True, 15:43:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:43:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:43:26 INFO - 'work_dir': 'build'} 15:43:26 INFO - ##### 15:43:26 INFO - ##### Running clobber step. 15:43:26 INFO - ##### 15:43:26 INFO - Running pre-action listener: _resource_record_pre_action 15:43:26 INFO - Running main action method: clobber 15:43:26 INFO - rmtree: /builds/slave/test/build 15:43:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:43:27 INFO - Running post-action listener: _resource_record_post_action 15:43:27 INFO - ##### 15:43:27 INFO - ##### Finished clobber step (success) 15:43:27 INFO - ##### 15:43:27 INFO - ##### 15:43:27 INFO - ##### Running read-buildbot-config step. 15:43:27 INFO - ##### 15:43:27 INFO - Running pre-action listener: _resource_record_pre_action 15:43:27 INFO - Running main action method: read_buildbot_config 15:43:27 INFO - Using buildbot properties: 15:43:27 INFO - { 15:43:27 INFO - "project": "", 15:43:27 INFO - "product": "firefox", 15:43:27 INFO - "script_repo_revision": "production", 15:43:27 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:43:27 INFO - "repository": "", 15:43:27 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 15:43:27 INFO - "buildid": "20160630123004", 15:43:27 INFO - "pgo_build": "True", 15:43:27 INFO - "basedir": "/builds/slave/test", 15:43:27 INFO - "buildnumber": 6, 15:43:27 INFO - "slavename": "talos-linux64-ix-042", 15:43:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:43:27 INFO - "platform": "ubuntu64_hw", 15:43:27 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:43:27 INFO - "branch": "autoland", 15:43:27 INFO - "repo_path": "integration/autoland", 15:43:27 INFO - "revision": "2f3a0b0aab552654bd8bc2bbfe84c8ec24023ae1", 15:43:27 INFO - "stage_platform": "linux64-pgo", 15:43:27 INFO - "builduid": "24431ea62254404cb3012890ef335693", 15:43:27 INFO - "slavebuilddir": "test" 15:43:27 INFO - } 15:43:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:43:27 INFO - Running post-action listener: _resource_record_post_action 15:43:27 INFO - ##### 15:43:27 INFO - ##### Finished read-buildbot-config step (success) 15:43:27 INFO - ##### 15:43:27 INFO - ##### 15:43:27 INFO - ##### Running download-and-extract step. 15:43:27 INFO - ##### 15:43:27 INFO - Running pre-action listener: _resource_record_pre_action 15:43:27 INFO - Running main action method: download_and_extract 15:43:27 INFO - mkdir: /builds/slave/test/build/tests 15:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:27 INFO - https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:43:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:43:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:43:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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 15:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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 15:43:28 INFO - Downloaded 1361 bytes. 15:43:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:43:28 INFO - Using the following test package requirements: 15:43:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:43:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:43:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:43:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:28 INFO - u'jsshell-linux-x86_64.zip'], 15:43:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:43:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:43:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:43:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:43:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:43:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:43:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:43:28 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')]} 15:43:28 INFO - https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:43:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:43:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:43:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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 15:43:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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 15:43:29 INFO - Downloaded 24267934 bytes. 15:43:29 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'] 15:43:29 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 15:43:30 INFO - Return code: 0 15:43:30 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 15:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:30 INFO - https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:43:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:43:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:43:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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 15:43:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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 15:43:31 INFO - Downloaded 24267934 bytes. 15:43:31 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'] 15:43:31 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 15:43:33 INFO - Return code: 0 15:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:43:33 INFO - https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:43:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:43:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:43:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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 15:43:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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 15:43:34 INFO - Downloaded 14405242 bytes. 15:43:34 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'] 15:43:34 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 15:43:34 INFO - Return code: 0 15:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:34 INFO - https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:43:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:43:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:43:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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 15:43:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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 15:43:35 INFO - Downloaded 60326783 bytes. 15:43:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:43:35 INFO - mkdir: /builds/slave/test/properties 15:43:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:43:35 INFO - Writing to file /builds/slave/test/properties/build_url 15:43:35 INFO - Contents: 15:43:35 INFO - build_url:https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:43:36 INFO - Running post-action listener: _resource_record_post_action 15:43:36 INFO - Running post-action listener: set_extra_try_arguments 15:43:36 INFO - ##### 15:43:36 INFO - ##### Finished download-and-extract step (success) 15:43:36 INFO - ##### 15:43:36 INFO - ##### 15:43:36 INFO - ##### Running populate-webroot step. 15:43:36 INFO - ##### 15:43:36 INFO - Running pre-action listener: _resource_record_pre_action 15:43:36 INFO - Running main action method: populate_webroot 15:43:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:43:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:43:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:43:36 INFO - '--tppagecycles', 15:43:36 INFO - '7'], 15:43:36 INFO - 'tests': ['tsvgm']}}, 15:43:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:43:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:43:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:43:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:43:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:36 INFO - 'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:36 INFO - 'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['damp', 'tps']}, 15:43:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:36 INFO - 'tests': ['damp', 'tps']}, 15:43:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['dromaeo_dom']}, 15:43:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:43:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['basic_compositor_video']}, 15:43:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:43:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['a11yr', 15:43:36 INFO - 'ts_paint', 15:43:36 INFO - 'tpaint', 15:43:36 INFO - 'sessionrestore', 15:43:36 INFO - 'sessionrestore_no_auto_restore', 15:43:36 INFO - 'tabpaint']}, 15:43:36 INFO - 'other-e10s': {'tests': ['a11yr', 15:43:36 INFO - 'ts_paint', 15:43:36 INFO - 'tpaint', 15:43:36 INFO - 'sessionrestore', 15:43:36 INFO - 'sessionrestore_no_auto_restore', 15:43:36 INFO - 'tabpaint']}, 15:43:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:43:36 INFO - 'ts_paint', 15:43:36 INFO - 'tpaint', 15:43:36 INFO - 'sessionrestore', 15:43:36 INFO - 'sessionrestore_no_auto_restore', 15:43:36 INFO - 'tabpaint']}, 15:43:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:43:36 INFO - 'ts_paint', 15:43:36 INFO - 'tpaint', 15:43:36 INFO - 'sessionrestore', 15:43:36 INFO - 'sessionrestore_no_auto_restore', 15:43:36 INFO - 'tabpaint']}, 15:43:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['a11yr', 15:43:36 INFO - 'ts_paint', 15:43:36 INFO - 'tpaint', 15:43:36 INFO - 'sessionrestore', 15:43:36 INFO - 'sessionrestore_no_auto_restore', 15:43:36 INFO - 'tabpaint']}, 15:43:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['a11yr', 15:43:36 INFO - 'ts_paint', 15:43:36 INFO - 'tpaint', 15:43:36 INFO - 'sessionrestore', 15:43:36 INFO - 'sessionrestore_no_auto_restore', 15:43:36 INFO - 'tabpaint']}, 15:43:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['tsvgx', 15:43:36 INFO - 'tsvgr_opacity', 15:43:36 INFO - 'tart', 15:43:36 INFO - 'tscrollx', 15:43:36 INFO - 'cart']}, 15:43:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:43:36 INFO - 'tsvgr_opacity', 15:43:36 INFO - 'tart', 15:43:36 INFO - 'tscrollx', 15:43:36 INFO - 'cart']}, 15:43:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:36 INFO - 'talos_options': ['--disable-e10s'], 15:43:36 INFO - 'tests': ['tp5o']}, 15:43:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:36 INFO - 'tests': ['tp5o']}, 15:43:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:36 INFO - 'talos_options': ['--disable-e10s', 15:43:36 INFO - '--xperf_path', 15:43:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:36 INFO - 'tests': ['tp5n']}, 15:43:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:36 INFO - 'talos_options': ['--xperf_path', 15:43:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:36 INFO - 'tests': ['tp5n']}}, 15:43:36 INFO - 'talos.zip': {'path': '', 15:43:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:43:36 INFO - Running post-action listener: _resource_record_post_action 15:43:36 INFO - ##### 15:43:36 INFO - ##### Finished populate-webroot step (success) 15:43:36 INFO - ##### 15:43:36 INFO - ##### 15:43:36 INFO - ##### Running create-virtualenv step. 15:43:36 INFO - ##### 15:43:36 INFO - Running pre-action listener: _resource_record_pre_action 15:43:36 INFO - Running main action method: create_virtualenv 15:43:36 INFO - Creating virtualenv /builds/slave/test/build/venv 15:43:36 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 15:43:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:43:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:43:36 INFO - Using real prefix '/usr' 15:43:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:43:37 INFO - Installing distribute.............................................................................................................................................................................................done. 15:43:39 INFO - Installing pip.................done. 15:43:39 INFO - Return code: 0 15:43:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b33b0>, '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 0x17b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b4740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', '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 15:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:43:39 INFO - Using env: {'DISPLAY': ':0', 15:43:39 INFO - 'HOME': '/home/cltbld', 15:43:39 INFO - 'LANG': 'en_US.UTF-8', 15:43:39 INFO - 'LANGUAGE': 'en_US:en', 15:43:39 INFO - 'LOGNAME': 'cltbld', 15:43:39 INFO - 'MAIL': '/var/mail/cltbld', 15:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:39 INFO - 'MOZ_NO_REMOTE': '1', 15:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:39 INFO - 'NO_EM_RESTART': '1', 15:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:39 INFO - 'PWD': '/builds/slave/test', 15:43:39 INFO - 'SHELL': '/bin/bash', 15:43:39 INFO - 'SHLVL': '1', 15:43:39 INFO - 'TERM': 'linux', 15:43:39 INFO - 'TMOUT': '86400', 15:43:39 INFO - 'USER': 'cltbld', 15:43:39 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', 15:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:39 INFO - '_': '/tools/buildbot/bin/python'} 15:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:39 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 15:43:39 INFO - Cleaning up... 15:43:39 INFO - Return code: 0 15:43:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b33b0>, '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 0x17b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b4740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', '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 15:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:43:39 INFO - Using env: {'DISPLAY': ':0', 15:43:39 INFO - 'HOME': '/home/cltbld', 15:43:39 INFO - 'LANG': 'en_US.UTF-8', 15:43:39 INFO - 'LANGUAGE': 'en_US:en', 15:43:39 INFO - 'LOGNAME': 'cltbld', 15:43:39 INFO - 'MAIL': '/var/mail/cltbld', 15:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:39 INFO - 'MOZ_NO_REMOTE': '1', 15:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:39 INFO - 'NO_EM_RESTART': '1', 15:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:39 INFO - 'PWD': '/builds/slave/test', 15:43:39 INFO - 'SHELL': '/bin/bash', 15:43:39 INFO - 'SHLVL': '1', 15:43:39 INFO - 'TERM': 'linux', 15:43:39 INFO - 'TMOUT': '86400', 15:43:39 INFO - 'USER': 'cltbld', 15:43:39 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', 15:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:39 INFO - '_': '/tools/buildbot/bin/python'} 15:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:39 INFO - Downloading/unpacking psutil>=3.1.1 15:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:43:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:41 INFO - Installing collected packages: psutil 15:43:41 INFO - Running setup.py install for psutil 15:43:41 INFO - building 'psutil._psutil_linux' extension 15:43:41 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 15:43:41 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 15:43:41 INFO - building 'psutil._psutil_posix' extension 15:43:41 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 15:43:41 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 15:43:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:41 INFO - Successfully installed psutil 15:43:41 INFO - Cleaning up... 15:43:42 INFO - Return code: 0 15:43:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:43:42 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')]} 15:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:42 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')]} 15:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:42 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 0x14f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b33b0>, '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 0x17b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b4740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', '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 15:43:42 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 15:43:42 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 15:43:42 INFO - Using env: {'DISPLAY': ':0', 15:43:42 INFO - 'HOME': '/home/cltbld', 15:43:42 INFO - 'LANG': 'en_US.UTF-8', 15:43:42 INFO - 'LANGUAGE': 'en_US:en', 15:43:42 INFO - 'LOGNAME': 'cltbld', 15:43:42 INFO - 'MAIL': '/var/mail/cltbld', 15:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:42 INFO - 'MOZ_NO_REMOTE': '1', 15:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:42 INFO - 'NO_EM_RESTART': '1', 15:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:42 INFO - 'PWD': '/builds/slave/test', 15:43:42 INFO - 'SHELL': '/bin/bash', 15:43:42 INFO - 'SHLVL': '1', 15:43:42 INFO - 'TERM': 'linux', 15:43:42 INFO - 'TMOUT': '86400', 15:43:42 INFO - 'USER': 'cltbld', 15:43:42 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', 15:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:42 INFO - '_': '/tools/buildbot/bin/python'} 15:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:43:42 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 15:43:42 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 15:43:42 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 15:43:42 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 15:43:42 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 15:43:42 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 15:43:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:43:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:43:44 INFO - Installing collected packages: mozsystemmonitor 15:43:44 INFO - Running setup.py install for mozsystemmonitor 15:43:44 INFO - Successfully installed mozsystemmonitor 15:43:44 INFO - Cleaning up... 15:43:44 INFO - Return code: 0 15:43:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b33b0>, '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 0x17b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b4740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', '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 15:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:43:44 INFO - Using env: {'DISPLAY': ':0', 15:43:44 INFO - 'HOME': '/home/cltbld', 15:43:44 INFO - 'LANG': 'en_US.UTF-8', 15:43:44 INFO - 'LANGUAGE': 'en_US:en', 15:43:44 INFO - 'LOGNAME': 'cltbld', 15:43:44 INFO - 'MAIL': '/var/mail/cltbld', 15:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:44 INFO - 'MOZ_NO_REMOTE': '1', 15:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:44 INFO - 'NO_EM_RESTART': '1', 15:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:44 INFO - 'PWD': '/builds/slave/test', 15:43:44 INFO - 'SHELL': '/bin/bash', 15:43:44 INFO - 'SHLVL': '1', 15:43:44 INFO - 'TERM': 'linux', 15:43:44 INFO - 'TMOUT': '86400', 15:43:44 INFO - 'USER': 'cltbld', 15:43:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', 15:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:44 INFO - '_': '/tools/buildbot/bin/python'} 15:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:44 INFO - Downloading/unpacking jsonschema==2.5.1 15:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:43:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:43:46 INFO - warning: no files found matching '*.txt' 15:43:46 INFO - no previously-included directories found matching 'build' 15:43:46 INFO - no previously-included directories found matching 'dist' 15:43:46 INFO - no previously-included directories found matching '.git*' 15:43:46 INFO - Installing collected packages: jsonschema, functools32 15:43:46 INFO - Running setup.py install for functools32 15:43:46 INFO - warning: no files found matching '*.txt' 15:43:46 INFO - no previously-included directories found matching 'build' 15:43:46 INFO - no previously-included directories found matching 'dist' 15:43:46 INFO - no previously-included directories found matching '.git*' 15:43:46 INFO - Successfully installed jsonschema functools32 15:43:46 INFO - Cleaning up... 15:43:46 INFO - Return code: 0 15:43:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:46 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 0x14f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b33b0>, '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 0x17b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b4740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', '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 15:43:46 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 15:43:46 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 15:43:46 INFO - Using env: {'DISPLAY': ':0', 15:43:46 INFO - 'HOME': '/home/cltbld', 15:43:46 INFO - 'LANG': 'en_US.UTF-8', 15:43:46 INFO - 'LANGUAGE': 'en_US:en', 15:43:46 INFO - 'LOGNAME': 'cltbld', 15:43:46 INFO - 'MAIL': '/var/mail/cltbld', 15:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:46 INFO - 'MOZ_NO_REMOTE': '1', 15:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:46 INFO - 'NO_EM_RESTART': '1', 15:43:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:46 INFO - 'PWD': '/builds/slave/test', 15:43:46 INFO - 'SHELL': '/bin/bash', 15:43:46 INFO - 'SHLVL': '1', 15:43:46 INFO - 'TERM': 'linux', 15:43:46 INFO - 'TMOUT': '86400', 15:43:46 INFO - 'USER': 'cltbld', 15:43:46 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', 15:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:46 INFO - '_': '/tools/buildbot/bin/python'} 15:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43:49 INFO - Downloading blobuploader-1.2.4.tar.gz 15:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:43:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:43:49 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 15:43:49 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 15:43:49 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 15:43:49 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 15:43:49 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 15:43:49 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 15:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:43:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:43:49 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 15:43:49 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 15:43:49 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 15:43:49 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 15:43:49 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 15:43:49 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 15:43:49 INFO - Downloading docopt-0.6.1.tar.gz 15:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:43:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:43:49 INFO - Running setup.py install for blobuploader 15:43:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:43:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:43:50 INFO - Running setup.py install for requests 15:43:50 INFO - Running setup.py install for docopt 15:43:50 INFO - Successfully installed blobuploader requests docopt 15:43:50 INFO - Cleaning up... 15:43:50 INFO - Return code: 0 15:43:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:50 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 0x14f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b33b0>, '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 0x17b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b4740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', '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 15:43:50 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 15:43:50 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 15:43:50 INFO - Using env: {'DISPLAY': ':0', 15:43:50 INFO - 'HOME': '/home/cltbld', 15:43:50 INFO - 'LANG': 'en_US.UTF-8', 15:43:50 INFO - 'LANGUAGE': 'en_US:en', 15:43:50 INFO - 'LOGNAME': 'cltbld', 15:43:50 INFO - 'MAIL': '/var/mail/cltbld', 15:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:50 INFO - 'MOZ_NO_REMOTE': '1', 15:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:50 INFO - 'NO_EM_RESTART': '1', 15:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:50 INFO - 'PWD': '/builds/slave/test', 15:43:50 INFO - 'SHELL': '/bin/bash', 15:43:50 INFO - 'SHLVL': '1', 15:43:50 INFO - 'TERM': 'linux', 15:43:50 INFO - 'TMOUT': '86400', 15:43:50 INFO - 'USER': 'cltbld', 15:43:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', 15:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:50 INFO - '_': '/tools/buildbot/bin/python'} 15:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:50 INFO - Running setup.py (path:/tmp/pip-CyE2lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:50 INFO - Running setup.py (path:/tmp/pip-hp3aYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:50 INFO - Running setup.py (path:/tmp/pip-H9oiiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:51 INFO - Running setup.py (path:/tmp/pip-paZtCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:51 INFO - Running setup.py (path:/tmp/pip-neHHYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:51 INFO - Running setup.py (path:/tmp/pip-b8DAQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:51 INFO - Running setup.py (path:/tmp/pip-Wzipvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:51 INFO - Running setup.py (path:/tmp/pip-D6oM9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:51 INFO - Running setup.py (path:/tmp/pip-226DSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:51 INFO - Running setup.py (path:/tmp/pip-56PSnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:51 INFO - Running setup.py (path:/tmp/pip-sJsTUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:51 INFO - Running setup.py (path:/tmp/pip-55qPeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:51 INFO - Running setup.py (path:/tmp/pip-dN3Agl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:51 INFO - Running setup.py (path:/tmp/pip-N_sTyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:51 INFO - Running setup.py (path:/tmp/pip-L2umfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:51 INFO - Running setup.py (path:/tmp/pip-_O_Y6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:51 INFO - Running setup.py (path:/tmp/pip-vmJIlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:43:52 INFO - Running setup.py install for manifestparser 15:43:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:43:52 INFO - Running setup.py install for mozcrash 15:43:52 INFO - Running setup.py install for mozdebug 15:43:52 INFO - Running setup.py install for mozdevice 15:43:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:43:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:43:52 INFO - Running setup.py install for mozfile 15:43:52 INFO - Running setup.py install for mozhttpd 15:43:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:43:52 INFO - Running setup.py install for mozinfo 15:43:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:43:52 INFO - Running setup.py install for mozInstall 15:43:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:43:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:43:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:43:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:43:52 INFO - Running setup.py install for mozleak 15:43:52 INFO - Running setup.py install for mozlog 15:43:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:43:53 INFO - Running setup.py install for moznetwork 15:43:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:43:53 INFO - Running setup.py install for mozprocess 15:43:53 INFO - Running setup.py install for mozprofile 15:43:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:43:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:43:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:43:53 INFO - Running setup.py install for mozrunner 15:43:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:43:53 INFO - Running setup.py install for mozscreenshot 15:43:53 INFO - Running setup.py install for moztest 15:43:53 INFO - Running setup.py install for mozversion 15:43:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:43:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:43:53 INFO - Cleaning up... 15:43:53 INFO - Return code: 0 15:43:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:53 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 0x14f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b33b0>, '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 0x17b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b4740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', '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 15:43:53 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 15:43:53 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 15:43:53 INFO - Using env: {'DISPLAY': ':0', 15:43:53 INFO - 'HOME': '/home/cltbld', 15:43:53 INFO - 'LANG': 'en_US.UTF-8', 15:43:53 INFO - 'LANGUAGE': 'en_US:en', 15:43:53 INFO - 'LOGNAME': 'cltbld', 15:43:53 INFO - 'MAIL': '/var/mail/cltbld', 15:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:53 INFO - 'MOZ_NO_REMOTE': '1', 15:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:53 INFO - 'NO_EM_RESTART': '1', 15:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:53 INFO - 'PWD': '/builds/slave/test', 15:43:53 INFO - 'SHELL': '/bin/bash', 15:43:53 INFO - 'SHLVL': '1', 15:43:53 INFO - 'TERM': 'linux', 15:43:53 INFO - 'TMOUT': '86400', 15:43:53 INFO - 'USER': 'cltbld', 15:43:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', 15:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:53 INFO - '_': '/tools/buildbot/bin/python'} 15:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:54 INFO - Running setup.py (path:/tmp/pip-bGDuvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:54 INFO - Running setup.py (path:/tmp/pip-UDC6cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:54 INFO - Running setup.py (path:/tmp/pip-eQgjVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:54 INFO - Running setup.py (path:/tmp/pip-3OJST1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:54 INFO - Running setup.py (path:/tmp/pip-uwxOH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:54 INFO - Running setup.py (path:/tmp/pip-EeGJzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:54 INFO - Running setup.py (path:/tmp/pip-5VoG54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:54 INFO - Running setup.py (path:/tmp/pip-TTpdla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:54 INFO - Running setup.py (path:/tmp/pip-O8vZoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:54 INFO - Running setup.py (path:/tmp/pip-TzBHkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:54 INFO - Running setup.py (path:/tmp/pip-bUiAUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:54 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)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:54 INFO - Running setup.py (path:/tmp/pip-nurGw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:54 INFO - Running setup.py (path:/tmp/pip-nz0Xxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:55 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)) 15:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:55 INFO - Running setup.py (path:/tmp/pip-rMvtes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:55 INFO - Running setup.py (path:/tmp/pip-se4go9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:55 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)) 15:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:55 INFO - Running setup.py (path:/tmp/pip-5sSTpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:55 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)) 15:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:55 INFO - Running setup.py (path:/tmp/pip-ddGl2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:55 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)) 15:43:55 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)) 15:43:55 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)) 15:43:55 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)) 15:43:55 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)) 15:43:55 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)) 15:43:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:43:55 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 15:43:55 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 15:43:55 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 15:43:55 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 15:43:55 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 15:43:55 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 15:43:57 INFO - Downloading blessings-1.6.tar.gz 15:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:43:57 INFO - Installing collected packages: blessings 15:43:57 INFO - Running setup.py install for blessings 15:43:57 INFO - Successfully installed blessings 15:43:57 INFO - Cleaning up... 15:43:57 INFO - Return code: 0 15:43:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:43:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:57 INFO - Reading from file tmpfile_stdout 15:43:57 INFO - Current package versions: 15:43:57 INFO - argparse == 1.2.1 15:43:57 INFO - blessings == 1.6 15:43:57 INFO - blobuploader == 1.2.4 15:43:57 INFO - docopt == 0.6.1 15:43:57 INFO - functools32 == 3.2.3-2 15:43:57 INFO - jsonschema == 2.5.1 15:43:57 INFO - manifestparser == 1.1 15:43:57 INFO - mozInstall == 1.12 15:43:57 INFO - mozcrash == 0.17 15:43:57 INFO - mozdebug == 0.1 15:43:57 INFO - mozdevice == 0.48 15:43:57 INFO - mozfile == 1.2 15:43:57 INFO - mozhttpd == 0.7 15:43:57 INFO - mozinfo == 0.9 15:43:57 INFO - mozleak == 0.1 15:43:57 INFO - mozlog == 3.2 15:43:57 INFO - moznetwork == 0.27 15:43:57 INFO - mozprocess == 0.22 15:43:57 INFO - mozprofile == 0.28 15:43:57 INFO - mozrunner == 6.11 15:43:57 INFO - mozscreenshot == 0.1 15:43:57 INFO - mozsystemmonitor == 0.3 15:43:57 INFO - moztest == 0.7 15:43:57 INFO - mozversion == 1.4 15:43:57 INFO - psutil == 3.1.1 15:43:57 INFO - requests == 1.2.3 15:43:57 INFO - wsgiref == 0.1.2 15:43:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:57 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 0x14f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b33b0>, '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 0x17b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b4740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', '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 15:43:57 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 15:43:57 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 15:43:57 INFO - Using env: {'DISPLAY': ':0', 15:43:57 INFO - 'HOME': '/home/cltbld', 15:43:57 INFO - 'LANG': 'en_US.UTF-8', 15:43:57 INFO - 'LANGUAGE': 'en_US:en', 15:43:57 INFO - 'LOGNAME': 'cltbld', 15:43:57 INFO - 'MAIL': '/var/mail/cltbld', 15:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:57 INFO - 'MOZ_NO_REMOTE': '1', 15:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:57 INFO - 'NO_EM_RESTART': '1', 15:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:57 INFO - 'PWD': '/builds/slave/test', 15:43:57 INFO - 'SHELL': '/bin/bash', 15:43:57 INFO - 'SHLVL': '1', 15:43:57 INFO - 'TERM': 'linux', 15:43:57 INFO - 'TMOUT': '86400', 15:43:57 INFO - 'USER': 'cltbld', 15:43:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', 15:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:57 INFO - '_': '/tools/buildbot/bin/python'} 15:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 INFO - Cleaning up... 15:43:57 INFO - Return code: 0 15:43:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:57 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 0x14f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b33b0>, '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 0x17b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b4740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', '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 15:43:57 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 15:43:57 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 15:43:57 INFO - Using env: {'DISPLAY': ':0', 15:43:57 INFO - 'HOME': '/home/cltbld', 15:43:57 INFO - 'LANG': 'en_US.UTF-8', 15:43:57 INFO - 'LANGUAGE': 'en_US:en', 15:43:57 INFO - 'LOGNAME': 'cltbld', 15:43:57 INFO - 'MAIL': '/var/mail/cltbld', 15:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:57 INFO - 'MOZ_NO_REMOTE': '1', 15:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:57 INFO - 'NO_EM_RESTART': '1', 15:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:57 INFO - 'PWD': '/builds/slave/test', 15:43:57 INFO - 'SHELL': '/bin/bash', 15:43:57 INFO - 'SHLVL': '1', 15:43:57 INFO - 'TERM': 'linux', 15:43:57 INFO - 'TMOUT': '86400', 15:43:57 INFO - 'USER': 'cltbld', 15:43:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', 15:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:57 INFO - '_': '/tools/buildbot/bin/python'} 15:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:43:58 INFO - Cleaning up... 15:43:58 INFO - Return code: 0 15:43:58 INFO - Running post-action listener: _resource_record_post_action 15:43:58 INFO - Running post-action listener: _start_resource_monitoring 15:43:58 INFO - Starting resource monitoring. 15:43:58 INFO - ##### 15:43:58 INFO - ##### Finished create-virtualenv step (success) 15:43:58 INFO - ##### 15:43:58 INFO - ##### 15:43:58 INFO - ##### Running install step. 15:43:58 INFO - ##### 15:43:58 INFO - Running pre-action listener: _resource_record_pre_action 15:43:58 INFO - Running main action method: install 15:43:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:58 INFO - Reading from file tmpfile_stdout 15:43:58 INFO - Detecting whether we're running mozinstall >=1.0... 15:43:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:43:58 INFO - Reading from file tmpfile_stdout 15:43:58 INFO - Output received: 15:43:58 INFO - Usage: mozinstall [options] installer 15:43:58 INFO - Options: 15:43:58 INFO - -h, --help show this help message and exit 15:43:58 INFO - -d DEST, --destination=DEST 15:43:58 INFO - Directory to install application into. [default: 15:43:58 INFO - "/builds/slave/test"] 15:43:58 INFO - --app=APP Application being installed. [default: firefox] 15:43:58 INFO - mkdir: /builds/slave/test/build/application 15:43:58 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'] 15:43:58 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 15:44:15 INFO - Reading from file tmpfile_stdout 15:44:15 INFO - Output received: 15:44:15 INFO - /builds/slave/test/build/application/firefox/firefox 15:44:15 INFO - Running post-action listener: _resource_record_post_action 15:44:15 INFO - ##### 15:44:15 INFO - ##### Finished install step (success) 15:44:15 INFO - ##### 15:44:15 INFO - ##### 15:44:15 INFO - ##### Running run-tests step. 15:44:15 INFO - ##### 15:44:15 INFO - Running pre-action listener: _resource_record_pre_action 15:44:15 INFO - Running main action method: run_tests 15:44:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:44:15 INFO - Python 2.7.3 15:44:15 INFO - Return code: 0 15:44:15 INFO - grabbing minidump binary from tooltool 15:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:15 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 0x17b33b0>, '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 0x17b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:44:15 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 15:44:15 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 15:44:15 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 15:44:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:44:15 INFO - Return code: 0 15:44:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:44:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:44:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:44:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:44:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:44:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 15:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 15:44:15 INFO - Using env: {'DISPLAY': ':0', 15:44:15 INFO - 'HOME': '/home/cltbld', 15:44:15 INFO - 'LANG': 'en_US.UTF-8', 15:44:15 INFO - 'LANGUAGE': 'en_US:en', 15:44:15 INFO - 'LOGNAME': 'cltbld', 15:44:15 INFO - 'MAIL': '/var/mail/cltbld', 15:44:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:15 INFO - 'MOZ_NO_REMOTE': '1', 15:44:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:15 INFO - 'NO_EM_RESTART': '1', 15:44:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:15 INFO - 'PWD': '/builds/slave/test', 15:44:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:15 INFO - 'SHELL': '/bin/bash', 15:44:15 INFO - 'SHLVL': '1', 15:44:15 INFO - 'TERM': 'linux', 15:44:15 INFO - 'TMOUT': '86400', 15:44:15 INFO - 'USER': 'cltbld', 15:44:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519', 15:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:15 INFO - '_': '/tools/buildbot/bin/python'} 15:44:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 15:44:15 INFO - mozversion application_buildid: 20160630123004 15:44:15 INFO - mozversion application_changeset: 2f3a0b0aab552654bd8bc2bbfe84c8ec24023ae1 15:44:15 INFO - mozversion application_display_name: Nightly 15:44:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:44:15 INFO - mozversion application_name: Firefox 15:44:15 INFO - mozversion application_remotingname: firefox 15:44:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:44:15 INFO - mozversion application_vendor: Mozilla 15:44:15 INFO - mozversion application_version: 50.0a1 15:44:15 INFO - mozversion platform_buildid: 20160630123004 15:44:15 INFO - mozversion platform_changeset: 2f3a0b0aab552654bd8bc2bbfe84c8ec24023ae1 15:44:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:44:15 INFO - mozversion platform_version: 50.0a1 15:44:15 INFO - using testdate: 1467326655 15:44:15 INFO - actual date: 1467326655 15:44:15 INFO - starting webserver on 'localhost:42027' 15:44:15 INFO - SUITE-START | Running 2 tests 15:44:15 INFO - TEST-START | dromaeo_css 15:44:15 INFO - operating with platform_type : linux_ 15:44:15 INFO - Initialising browser for dromaeo_css test... 15:44:15 INFO - TEST-INFO | started process 17904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplqqq5C/profile http://localhost:42027/getInfo.html) 15:44:20 INFO - PROCESS | 17904 | __metrics Screen width/height:1600/1200 15:44:20 INFO - PROCESS | 17904 | colorDepth:24 15:44:20 INFO - PROCESS | 17904 | Browser inner width/height: 1024/697 15:44:20 INFO - PROCESS | 17904 | __metrics 15:44:21 INFO - PROCESS | 17904 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:44:21 INFO - TEST-INFO | 17904: exit 0 15:44:21 INFO - Browser initialized. 15:44:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:44:21 INFO - TEST-INFO | started process 17988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplqqq5C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:33 INFO - PROCESS | 17988 | RSS: Main: 157581312 15:44:33 INFO - PROCESS | 17988 | 15:45:25 INFO - PROCESS | 17988 | 1467326725301 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] 15:47:33 INFO - PROCESS | 17988 | Cycle 1(1): loaded http://localhost:42027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42027/tests/dromaeo/cssquery-ext.html) 15:47:34 INFO - PROCESS | 17988 | RSS: Main: 256774144 15:47:34 INFO - PROCESS | 17988 | 15:50:36 INFO - PROCESS | 17988 | Cycle 1(1): loaded http://localhost:42027/tests/dromaeo/cssquery-ext.html (next: http://localhost:42027/tests/dromaeo/cssquery-jquery.html) 15:50:37 INFO - PROCESS | 17988 | RSS: Main: 240963584 15:50:37 INFO - PROCESS | 17988 | 15:53:39 INFO - PROCESS | 17988 | Cycle 1(1): loaded http://localhost:42027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42027/tests/dromaeo/cssquery-mootools.html) 15:53:39 INFO - PROCESS | 17988 | RSS: Main: 236535808 15:53:39 INFO - PROCESS | 17988 | 15:56:41 INFO - PROCESS | 17988 | Cycle 1(1): loaded http://localhost:42027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42027/tests/dromaeo/cssquery-prototype.html) 15:56:42 INFO - PROCESS | 17988 | RSS: Main: 235700224 15:56:42 INFO - PROCESS | 17988 | 15:59:45 INFO - PROCESS | 17988 | Cycle 1(1): loaded http://localhost:42027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42027/tests/dromaeo/cssquery-yui.html) 15:59:45 INFO - PROCESS | 17988 | RSS: Main: 224063488 15:59:45 INFO - PROCESS | 17988 | 16:02:48 INFO - PROCESS | 17988 | Cycle 1(1): loaded http://localhost:42027/tests/dromaeo/cssquery-yui.html (next: http://localhost:42027/tests/dromaeo/cssquery-dojo.html) 16:02:48 INFO - PROCESS | 17988 | RSS: Main: 301563904 16:02:48 INFO - PROCESS | 17988 | 16:02:48 INFO - PROCESS | 17988 | __start_tp_report 16:02:48 INFO - PROCESS | 17988 | _x_x_mozilla_page_load 16:02:48 INFO - PROCESS | 17988 | _x_x_mozilla_page_load_details 16:02:48 INFO - PROCESS | 17988 | |i|pagename|runs| 16:02:48 INFO - PROCESS | 17988 | |0;dojo.html;3113.7976031557932;3116.3455674308398;3136.1375621704024;3156.1005113542647;3176.332970076284;5263.921041184385;5323.707196104213;5374.758135883885;5424.728763561821;5425.213344065113;5345.33183352081;5347.197920311945;5357.357117145948;5357.866053348658;5388.9191662125;4811.302361157639;4874.805007799684;4889.584385327252;4895.0454661341055;5076.187809950408;4938.432080310774;4956.231784073474;5010.674306170087;5025.3718285214345;5028.7988480460735;4801.303810947411;4853.344798452216;4896.216605343128;4914.213725803854;4915.754212289389;4886.096072226649;4911.336969509106;4979.45226025137;4982.476839931791;5025.271335656309;4803.063402636487;4937.259411088329;4943.283223932545;4957.925631115536;4978.900421991576;5337.039332920072;5422.91865622016;5431.21247419122;5476.397596264408;5490;5848;5863.205172302043;5873.823785286449;5889.911651325191;5897.32180799205;5684.7157642118145;5714.228579141804;5800.042992906166;5881.588288819784;5882.499987501067;5346.91979620306;5368.221607866837;5436.184572314145;5442.265294185314;5442.510174084312;5914.6746928918465;5920.141579470953;5921.940780592139;5922.437368449991;5925.318588362307;5581.190727344512;5619.578531610146;5659;5696.686682232517;5699.373068962411;5834.912476312858;5850.444207800252;5854.853628659318;5856.8535786604825;5857.209276747584;5744.253247077937;5783.392743761929;5789.073748200268;5791.044477661138;5830.708464576839;5581.330240371181;5740.56945729072;5772.913406298909;5783.913241301384;5799.594028417971;4444.4888837784065;4446.510883802779;4446.510883802779;4448.132614140276;4478.14915166124;3970.7419017763755;3982.5818289079807;3993.2213218422708;3994.9001274967777;4024.7182697210915;5328.520433161034;5365.007473617393;5380.031594313061;5444.945550544523;5455.563554915597;5721.856953576111;5750.482456578844;5751.971240143773;5770.221020162225;5806.506446952057;5456.290682211366;5465;5473.616846820764;5474.7810087596845;5475.4524547544925;4891.926621100686;4902.117618828645;4929.556339929423;4940.036692844861;4968.453470118284;5905.793297234576;5907.8227653169615;5908.291005079418;5915.733791979371;5925.792597259076;5640.492355688008;5669.121286200645;5674.517665998436;5691.0040742869005;5697.145428185805;5946.583739138392;5963.075723262901;5985.790497332572;6033.758649653964;6034.668093254913;5669.092945128759;5716.685582292847;5726.2269593606;5728.971355143364;5736.110902810071;5545.750441230235;5749.425057494217;5799.449052340021;5821.243238378984;5836.533077353886;5625.437456254342;5679.716014199356;5698.2592263005545;5703.344115426779;5752.712364381848;5625.634333768292;5664.065429204135;5672.858178545569;5675.4892059713175;5709.371969083314;5387.946120538902;5458.426865179099;5489.835304940858;5598.86002849932;5614.85962850932;5645.435456454322;5651.406602306699;5676.347220069745;5703.7433315500075;5705.857353566028;5522.917156242579;5523.917141242804;5532.861678458071;5534.612577119724;5538 16:02:48 INFO - PROCESS | 17988 | |1;ext.html;588.3557504532536;617.9258488981322;620.667942650682;628.2523796681951;640.5228105061728;32756.836215818916;35772.64227357726;43134.13731725363;43965.560344396545;44003.77998110005;45751.77124114383;46152;46205;46219.76890115545;46300;8957.865632015524;9112.498812565307;9113.3165012624;9117.316201284897;9124.543772811367;8802.603882825257;8891;8895.510746908918;8898.154675305836;8899.95550022249;8889.599968001423;8915.331350148732;8941.016488186295;8942.284617230605;8942.687005954793;8858.11418858109;8904.554772261361;8905.376623636315;8919.28645708345;8947.060558641346;8897.777555561162;8942.46345219289;8952.686655967074;8965.506897120657;8967.686130985385;44139.11721765547;44471.11057778859;44521.77739111316;44541.77729111366;44806.55193448089;3863.459115723801;3880.1463677990796;3945.7237993340477;3966.3058964681063;4438.090191510732;32935.50596741051;33226.50480728373;33231.169220769436;33878.66121338804;34756.47865282023;4167.624913757776;4182.2890108681295;4229;4278.529361770203;4437.778111094464;374733;375467;378050.4267222649;378114;381710;37259.62740372616;38278.61721382751;60472;61077.694611526655;61212.69393653092;40139.59860401417;40178.39732404016;40266.79866600707;40284;40307.395389069185;15640.296186671627;15758.290876910567;15770.60573485649;15783.526494205193;15790.131542765028;13089;13131.34343282832;13135.540256090992;13139.934300328438;13155.73688526224;9061.456312621263;9135.634574617074;9147.95426022879;9187.08129187076;9200.263978881674;3406.4890266459734;3480.6693364130365;3492.650734926487;3496.930061398758;3509.6312438149143;1001.9562475795171;1022.1669339488442;1084.6637542361893;1120.1654767198327;1134.9902267493476;33227;33852.830735846655;33928.660713393045;34132;34406;1100.6422912553453;1126.6169502369235;1135.2620796482352;1149.2472430557998;1159.6984783956232;17591.912040439714;17830.37593684215;17843.375481858333;17981.640367192584;17993.19030643624;574836;575282;577952;579446;581717;62417.37582624116;63103.68448157822;63114.36885631085;63196.36803631997;63214.68392658007;1244.1601918705019;1268.9175203611735;1287.5622288421794;1303.6219496345952;1340.035174674233;30750.384992300475;34717.65282347144;34923;35296.82351588226;35384;55625.721871390386;56475.15287270612;56682.716586416806;56708.14937775854;56766;512867;524586;525050;527147;527416;45688.54311456843;47012.52987470081;47576.524234757206;47867.52132478631;47876.28185577289;51833.74083129711;52148.739256303474;52455.21317180169;52622;53411;43055;43299.567004329554;43491;44523;44959.55040449554;43836;44019;44058;44455;45216.32175517436;42940.35589466223;43734.56265437305;44175.77912110547;44355.77822110869;44363.55636443723;35715.46426803548;38755.61244387633;39228.080687038375;39304.58360747313;39834.20331593294;28572.285692857844;28900.855495723226;29166.770818230812;29314.560281595368;29486.705132948395 16:02:48 INFO - PROCESS | 17988 | |2;jquery.html;387.5368934123723;408.23863494582605;410.784338222433;415.738085006446;433.3175248982853;15752.763708544368;19372.70940935887;19881.105350259237;20001.59996800063;21755.23856665017;17996.55008624785;18001.54996125094;18269.908650456728;18311.267549298012;19917.30289439866;5656.349519805213;5720.2849643794425;5905.822825315247;5908.438698323674;5934.28788545373;5772.0476121439915;5820;5820.912686309709;5828.766849326022;5850.73671684773;5604.8038318658855;5805.274340707411;5853.356130825606;5859.29688437386;5864.091065884794;5785.623934444268;5789.218455508494;5796.304443466769;5797.971010144944;5801.53587712982;5180.922286165711;5491.615586908918;5497.697626630534;5576.470235327637;5586.050371436865;14187.219702916336;14468.059576127518;19929.701054484194;23522.176723814755;24788.25635230946;2354.21133920137;2367.7040369953756;2462.938426539333;2535.0873685473216;2538.0989748639336;10834.295770774954;12431.75136497274;12518.937405313007;15182.316795744107;15578.221088945507;1913.3972798568545;1958.4614231086423;1972.3195497553465;1975.980240197594;1988.721578978944;49918.7504062481;62842;66261.66869165671;79831.600841996;92595;10760.946195268974;11425.371604561662;11517.366544840113;11520.88479115198;11888.940555297168;16056.27746751399;16302.673946521003;16325.673486530202;16339.509814705578;16355.509334719978;8459.534725590152;8554.572271386405;8584.934888415864;8607.827843443221;8791.868121978176;8274.875876861852;8357.58212089393;8436.662533498715;8459.534725590152;8470.872936905951;4828.903421931542;4928.457869634337;4972.7513624318635;4986.850394488171;5069.5437410632485;2037.113855472874;2065.9380218593465;2071.181883156145;2093.216022689819;2099.9160033598487;897.3359713811863;937.5640327247862;1022.2384323678907;1053.546974800843;1056.8467572201987;19738;20126.29557965464;20611.69082463764;21027;21337.89331053335;1015.7816069545083;1022.6471867205802;1045.137761346892;1080.1628737728324;1084.0947808579924;10956.561737530568;11638.825417618742;11869.406529673483;11873;11890.702732431586;440946;443152;505412;518118;519607;56280.43719562752;90414;99865.50067249617;100029;100286;934.9953250233841;985.4284514981293;1016.5273147986222;1029.583018877356;1033.395463653771;18756;18787.812121878607;19153.425397238105;19204.71192932135;19222.903885480482;39525.80237098796;44293.55706442894;44557.61424741218;45536.77231613821;45975.31037034514;59123.40876591351;59275.40724592699;59894.70052649709;60362.69818650879;61538.076928847;8771.956140219258;8885.333599979898;9075.863862042206;9116.544172791466;9181.173694367539;13426.597202083953;13954.860451395356;13992.510262140777;14082.155070695791;14165.43338266499;11995.700107497034;12129;12232.449539770554;12630.179038362478;12942.547010854574;12047.698807529881;12380.133390662568;12400.19398739079;12433.756624337493;12553.811692824433;12117.15179937396;12305.753884922073;12438;12469.75060498803;12506.18709783861;8597.140285971353;9054.27565794748;9197.126273004054;9240.768980775534;9272.768180795534;11390.886091138982;11748.471318790846;12122.878771212529;12236.143469957018;12600 16:02:48 INFO - PROCESS | 17988 | |3;mootools.html;1482.9258537073147;1520.92395380231;1646.7941507311587;1788.4724006418105;1820.4447643468745;8756.255718263947;9371.765705857357;9454.385464944791;9461;9461.19579835714;8059.959700201505;8793.95603021984;9041.457512549252;9069.319801014934;9283.118103780147;2368.8341816072925;2390.414348484615;2397.328747950568;2398.688170537828;2398.8080953523763;2049.077914938276;2390.725066617344;2405.2423486601665;2422.236995346469;2427.3082171581104;2306.4925716342377;2362.48025434405;2366.5858474766933;2385.654080158376;2387.6299173628026;2388.0209114263157;2392.7009123859516;2398.3764221302413;2424.709034915804;2427.7936375407935;2386.474975505386;2393.102586530051;2403.146882856578;2404.362843846382;2416.8066554675584;9247.537623118817;9259.490728009956;9261.166495015414;9276.11876871696;9318.068193180628;5295.894082118374;5397.8380648580605;5437.510624043855;5441;5449.482299181611;3389.813560254185;3472.8365997390906;3512.121969507623;3544.6632569906074;3574.2136729919375;1052.6052730226165;1057.2810488867567;1057.428988346292;1081.9134469242442;1091.5251865438559;12998.285094319808;13156.934215328862;13193.40629671667;13198.14212076212;13214.66963325915;4607.654425918069;4719.622430205575;4818.903621927542;4864.464908860023;4881.414230292387;11061.336319820837;11068.28056176346;11068.723281918017;11069;11072.833907491395;5366.812161574404;5377.193420986805;5383.81156659515;5385.380681221632;5387.81142660005;4910.926336104962;4960.627952903546;4972.651914366032;4997.0505603935135;5083.669561478492;3827.5215598050245;3868.323043467382;3891.785951772623;3925.8822235332987;4049.8987525311513;1205.879412058787;1282.4229096906429;1285.607889593683;1289.8581156072823;1334.4928927007675;860.3481315873538;860.7159637319669;958.2382006305004;969.2972594868663;971.7522031881825;5851.853703657357;6101.664408457489;6163;6201.534884883652;6390.30491481418;995.5868314649484;998.4558415663481;1032.488917985602;1035.0477560644226;1035.1201478743008;4289.656827453796;4365.323374876899;4417.447819022622;4436.112777444524;4447.599716025573;10941.781164376827;11265.549378024787;11461.484233209525;11480.368579728196;11500.482478288497;10197.694069177936;11250.943745281385;11646.825297620542;11667.416629168507;11690.181687281809;8079.1516890725625;8421.915780842113;8433.536155511505;8604.8709269361;8629.309655227567;6336.7465301389275;6475.611463312216;6562.114114594468;6625.337466253336;6646.90029649546;10563.20775941792;10621.575136994743;10635.734106647396;10684.946575267073;10799.514021869192;10338;10672.146228301563;10947.83578246343;10989.560417583527;11059.778804424028;7865.764027079197;8329.208725171098;8470.915290847259;8532.573371331284;8537.786555335917;8822.867656985021;9190.908090919005;9204.631814727603;9213.401128926598;9235.76910577241;8037.23646253605;8214.219649133562;8234.505929644241;8292.792680183044;8387.161283871565;8021.799455013438;8034.67861285542;8149.062857771195;8215.876761848696;8219.589020549069;7509.9249007509225;7536.057992750906;7579.962100189464;7597.354224890946;7615.771526853981;5568.443155684399;5614.718270682752;5658.122990936411;5663.461971112738;5770.105633626795;5142.717150556755;5376.166694162411;5437.782488700408;5641.915371269352;5790.189373487631 16:02:48 INFO - PROCESS | 17988 | |4;prototype.html;335.4529354598419;336.18642884220185;345.7735183454838;346.37825103938434;349.14982018784247;5180.404253510838;5278;5349.090654588719;5387.272718183049;5404.729763511824;5257.789688412459;5275.36695596529;5285.656432331895;5289.788408463657;5315.202719592054;4180.352045432963;4196;4200.663946884242;4212.262854000553;4222.324428091506;4024.859129930453;4043.4339192512925;4152;4240.469941257343;4273.380359847836;4185.560516145792;4203;4225.471816022997;4234.449521562193;4244.662931176685;4199.7690127043;4214.852480163179;4223.092035212444;4228.936565951513;4232.76719780412;3666.2850744104912;3718.665320121202;3763.153290509641;3763.9247215055548;3779.2063666630042;5132.871678208037;5134.768935397916;5136.484737002594;5143.177091665353;5160.277561141444;4787.449443314029;4793.71237725734;4804.927926081112;4825.311141100622;4829.492903245144;5386.8383948481605;5547.55619550435;5551.2228288039705;5554.80585168856;5608.859778505529;4032.3548232282988;4034.6167114124405;4035.1929614077007;4035.233305671913;4045.02919299369;5750.3962083981;5797.449242321973;5834.095715164156;5847.152162936393;5848.824535263949;3957.960420395817;4120.464339635828;4130.648894843912;4140.956397048167;4150.066235097079;4170.895727606834;4181.310083836133;4183.410304084428;4193.308104162779;4199.538050814408;4741.099191153669;4744.620430365562;4771.642126840501;4776.9761151194025;4792.808287668524;5520.66875987442;5577.44225577439;5595.38450770415;5625.409332020161;5679.602427830095;1355.2884735513935;1386.9029167958347;1434.8852091832628;1437.4034775568023;1438.4821464272854;963.1572374172599;977.6040703515088;985.522021819417;991.3011327014437;1003.0972125087479;5272.868178295496;5313.521783039468;5313.787448502017;5313.920291195558;5330.600204984642;5564.10974244119;5567.3040869891265;5599.804006859822;5635.408282130399;5662;5119.923201151985;5348.893022139536;5363.088274993261;5397.271368365299;5412.185663454981;2712.742289482496;2720.8980362953034;2733.8223015503927;2763.5301998660275;2772.9306767330977;5099.796008159707;5202.869928251824;5208.947910520847;5219.765110570033;5259.526642602108;5154.613403994716;5483.8080667176455;5849.151872978395;5852.648841069549;5861.941380586225;5883.882322353529;5948.583599148104;5957.49361304294;5966.224390829165;5980.970095149583;5524.447555244444;5749.310082790092;5785.450382213683;5793.971030144822;5832.416758324303;5664.49019588239;5701.173329867229;5703.971480142573;5707.743151558273;5714.514266287412;5906.940930590639;5948.910766338595;5972.163897054329;5989.850253743517;5999.890020346075;3914.9021274468364;4087.8160482777753;4128.236276288896;4148.211839750437;4176.686748493815;5603.35561410443;5707.800226992035;5819.79630712923;5828.708564571839;5861.853453663522;5471.2613797138465;5591.692456914909;5597.384287728428;5609.653683116105;5622.437756224344;5582.29258809469;5588.552915766811;5596.86007849807;5630.211770352236;5640.294963129609;5282.656627319212;5501.944980550144;5525.889482210414;5526.143447765603;5532.30846144232;5591.692456914909;5623.550115990629;5638.379778224474;5640.774369025193;5659.603827732019;5246.61279118008;5502.449755024626;5511.834644960658;5535.501804837584;5574.581906356958 16:02:48 INFO - PROCESS | 17988 | |5;yui.html;757.2616698718749;821.1008945204999;841.9158084191581;844.3667249562828;862.1593945902746;16620.418285359985;16684.916575417123;16975.15124243786;17259.74110388345;17280.65438691227;15339.233038348093;15346;15489.767653485178;15514.30185641646;15518.68962620747;670.128832517725;800.8638531449639;807.1121766057335;823.333100188846;826.5495305058757;810.3031393002013;834.9039860416038;834.9165083491632;835.5780330932901;835.7701632051204;857.4340934982913;862.0474375814729;862.8921384826897;862.9266512346458;863.080818927843;685.746273878668;839.1273076000952;848.4061157189992;853.5007020892785;856.2935578148022;621.8165641135876;621.9720112594944;622.2222222222222;622.3558616831558;622.7477871462065;14795.630109247248;14889.851101488955;14914.776278355834;14918.403263869432;14937.7759333609;14440.49458268966;14630.341634626468;14655.780163297559;14871;14876.925615371962;13339.933300333436;13387.330633468287;13569.321533923265;13609.455621775118;13797.724045519033;4613.100445413146;4628.4445866496235;4661.417322834645;4813.3983252093485;4838.274258861164;72581;73019.63490182515;73565.63217183879;76576.61711691461;78090.21909780886;11203.054116363752;11287.943560282147;11356.096590485256;11404;11732.94133529327;20345.694814577793;20403.693944590843;20491.4877128073;20502.897485512774;20515;8869.911300887037;9190.63237470507;9209.539523023823;9340.486273255035;9342.90657093434;4982.153033984231;4986.925196122061;5006.89986200274;5101.438841727407;5269.051570717231;3542.4863394807608;3659.2864391443413;3661;3665.4135338345736;3669.486271921933;659.7888675623755;663.4559661077966;672.8351553869334;679.6601699150425;680.306087790451;637.4295005969724;730.6273800361854;733.2740586819117;759.7454852624322;786.3748320085546;9818.165455936183;10104.595816167419;10179.134773544332;10204.795904081877;10631.186078232493;681.7068660475944;688.3875691749821;725.1081170160732;731.177425396429;735.3235023778137;4741.596964258077;4814.266863928983;4903.313536104948;4955.108080545464;4955.677880937727;115533;116514;117870;118106;120380.39809800895;99147.50426247966;101453;101461;102425.48787256164;103484.48257758663;90925;91775.54112229396;91890;92540.0745992545;92840.53579732194;9255.398399104037;9284.907150928404;9293.72118836436;9398.859017114886;9595.376300540442;55404.44595554154;56390.71804640951;56771;57007;58862.41137588569;73178;77537;77700.22299777156;78673;79207.60396197982;12198.817017744563;12300.753984920431;12525.123241373381;12837.871621283668;12853.100282980102;13212.339383031001;13457.932710336385;13568;13677.179369237878;13852.515161969282;13118.672033199246;13166.934165329112;13444.327783610976;13769.173849569059;13838.169709817443;12673.93663031716;12716.745665086832;12926.482940682268;12983.545575904798;12992.805107923577;11844.76310473803;11956.222845515014;12219.816702749644;12226.813955336396;12284;10826.350418974887;11006.716756040989;11105.888941110485;11297.378644174649;11491.035592720498;10082.344647597884;10917.508712107816;10951.890481095406;10960.671179864617;11019 16:02:48 INFO - PROCESS | 17988 | __end_tp_report 16:02:48 INFO - PROCESS | 17988 | __start_cc_report 16:02:48 INFO - PROCESS | 17988 | _x_x_mozilla_cycle_collect,847 16:02:48 INFO - PROCESS | 17988 | __end_cc_report 16:02:48 INFO - PROCESS | 17988 | __startTimestamp1467327768873__endTimestamp 16:02:48 INFO - PROCESS | 17988 | 16:02:48 INFO - PROCESS | 17988 | ------- Summary: start ------- 16:02:48 INFO - PROCESS | 17988 | Number of tests: 6 16:02:48 INFO - PROCESS | 17988 | 16:02:48 INFO - PROCESS | 17988 | [#0] dojo.html Cycles:165 Average:5366.45 Median:5538.00 stddev:600.87 (10.8%) stddev-sans-first:576.14 16:02:48 INFO - PROCESS | 17988 | Values: 3113.8 3116.3 3136.1 3156.1 3176.3 5263.9 5323.7 5374.8 5424.7 5425.2 5345.3 5347.2 5357.4 5357.9 5388.9 4811.3 4874.8 4889.6 4895.0 5076.2 4938.4 4956.2 5010.7 5025.4 5028.8 4801.3 4853.3 4896.2 4914.2 4915.8 4886.1 4911.3 4979.5 4982.5 5025.3 4803.1 4937.3 4943.3 4957.9 4978.9 5337.0 5422.9 5431.2 5476.4 5490.0 5848.0 5863.2 5873.8 5889.9 5897.3 5684.7 5714.2 5800.0 5881.6 5882.5 5346.9 5368.2 5436.2 5442.3 5442.5 5914.7 5920.1 5921.9 5922.4 5925.3 5581.2 5619.6 5659.0 5696.7 5699.4 5834.9 5850.4 5854.9 5856.9 5857.2 5744.3 5783.4 5789.1 5791.0 5830.7 5581.3 5740.6 5772.9 5783.9 5799.6 4444.5 4446.5 4446.5 4448.1 4478.1 3970.7 3982.6 3993.2 3994.9 4024.7 5328.5 5365.0 5380.0 5444.9 5455.6 5721.9 5750.5 5752.0 5770.2 5806.5 5456.3 5465.0 5473.6 5474.8 5475.5 4891.9 4902.1 4929.6 4940.0 4968.5 5905.8 5907.8 5908.3 5915.7 5925.8 5640.5 5669.1 5674.5 5691.0 5697.1 5946.6 5963.1 5985.8 6033.8 6034.7 5669.1 5716.7 5726.2 5729.0 5736.1 5545.8 5749.4 5799.4 5821.2 5836.5 5625.4 5679.7 5698.3 5703.3 5752.7 5625.6 5664.1 5672.9 5675.5 5709.4 5387.9 5458.4 5489.8 5598.9 5614.9 5645.4 5651.4 5676.3 5703.7 5705.9 5522.9 5523.9 5532.9 5534.6 5538.0 16:02:48 INFO - PROCESS | 17988 | 16:02:48 INFO - PROCESS | 17988 | [#1] ext.html Cycles:180 Average:64956.77 Median:44011.39 stddev:133052.74 (302.3%) stddev-sans-first:133338.22 16:02:48 INFO - PROCESS | 17988 | Values: 588.4 617.9 620.7 628.3 640.5 32756.8 35772.6 43134.1 43965.6 44003.8 45751.8 46152.0 46205.0 46219.8 46300.0 8957.9 9112.5 9113.3 9117.3 9124.5 8802.6 8891.0 8895.5 8898.2 8900.0 8889.6 8915.3 8941.0 8942.3 8942.7 8858.1 8904.6 8905.4 8919.3 8947.1 8897.8 8942.5 8952.7 8965.5 8967.7 44139.1 44471.1 44521.8 44541.8 44806.6 3863.5 3880.1 3945.7 3966.3 4438.1 32935.5 33226.5 33231.2 33878.7 34756.5 4167.6 4182.3 4229.0 4278.5 4437.8 374733.0 375467.0 378050.4 378114.0 381710.0 37259.6 38278.6 60472.0 61077.7 61212.7 40139.6 40178.4 40266.8 40284.0 40307.4 15640.3 15758.3 15770.6 15783.5 15790.1 13089.0 13131.3 13135.5 13139.9 13155.7 9061.5 9135.6 9148.0 9187.1 9200.3 3406.5 3480.7 3492.7 3496.9 3509.6 1002.0 1022.2 1084.7 1120.2 1135.0 33227.0 33852.8 33928.7 34132.0 34406.0 1100.6 1126.6 1135.3 1149.2 1159.7 17591.9 17830.4 17843.4 17981.6 17993.2 574836.0 575282.0 577952.0 579446.0 581717.0 62417.4 63103.7 63114.4 63196.4 63214.7 1244.2 1268.9 1287.6 1303.6 1340.0 30750.4 34717.7 34923.0 35296.8 35384.0 55625.7 56475.2 56682.7 56708.1 56766.0 512867.0 524586.0 525050.0 527147.0 527416.0 45688.5 47012.5 47576.5 47867.5 47876.3 51833.7 52148.7 52455.2 52622.0 53411.0 43055.0 43299.6 43491.0 44523.0 44959.6 43836.0 44019.0 44058.0 44455.0 45216.3 42940.4 43734.6 44175.8 44355.8 44363.6 35715.5 38755.6 39228.1 39304.6 39834.2 28572.3 28900.9 29166.8 29314.6 29486.7 16:02:48 INFO - PROCESS | 17988 | 16:02:48 INFO - PROCESS | 17988 | [#2] jquery.html Cycles:180 Average:28898.46 Median:22638.71 stddev:80114.66 (353.9%) stddev-sans-first:80310.80 16:02:48 INFO - PROCESS | 17988 | Values: 387.5 408.2 410.8 415.7 433.3 15752.8 19372.7 19881.1 20001.6 21755.2 17996.6 18001.5 18269.9 18311.3 19917.3 5656.3 5720.3 5905.8 5908.4 5934.3 5772.0 5820.0 5820.9 5828.8 5850.7 5604.8 5805.3 5853.4 5859.3 5864.1 5785.6 5789.2 5796.3 5798.0 5801.5 5180.9 5491.6 5497.7 5576.5 5586.1 14187.2 14468.1 19929.7 23522.2 24788.3 2354.2 2367.7 2462.9 2535.1 2538.1 10834.3 12431.8 12518.9 15182.3 15578.2 1913.4 1958.5 1972.3 1976.0 1988.7 49918.8 62842.0 66261.7 79831.6 92595.0 10760.9 11425.4 11517.4 11520.9 11888.9 16056.3 16302.7 16325.7 16339.5 16355.5 8459.5 8554.6 8584.9 8607.8 8791.9 8274.9 8357.6 8436.7 8459.5 8470.9 4828.9 4928.5 4972.8 4986.9 5069.5 2037.1 2065.9 2071.2 2093.2 2099.9 897.3 937.6 1022.2 1053.5 1056.8 19738.0 20126.3 20611.7 21027.0 21337.9 1015.8 1022.6 1045.1 1080.2 1084.1 10956.6 11638.8 11869.4 11873.0 11890.7 440946.0 443152.0 505412.0 518118.0 519607.0 56280.4 90414.0 99865.5 100029.0 100286.0 935.0 985.4 1016.5 1029.6 1033.4 18756.0 18787.8 19153.4 19204.7 19222.9 39525.8 44293.6 44557.6 45536.8 45975.3 59123.4 59275.4 59894.7 60362.7 61538.1 8772.0 8885.3 9075.9 9116.5 9181.2 13426.6 13954.9 13992.5 14082.2 14165.4 11995.7 12129.0 12232.4 12630.2 12942.5 12047.7 12380.1 12400.2 12433.8 12553.8 12117.2 12305.8 12438.0 12469.8 12506.2 8597.1 9054.3 9197.1 9240.8 9272.8 11390.9 11748.5 12122.9 12236.1 12600.0 16:02:48 INFO - PROCESS | 17988 | 16:02:48 INFO - PROCESS | 17988 | [#3] mootools.html Cycles:180 Average:6099.06 Median:4841.68 stddev:3507.46 (72.4%) stddev-sans-first:3500.14 16:02:48 INFO - PROCESS | 17988 | Values: 1482.9 1520.9 1646.8 1788.5 1820.4 8756.3 9371.8 9454.4 9461.0 9461.2 8060.0 8794.0 9041.5 9069.3 9283.1 2368.8 2390.4 2397.3 2398.7 2398.8 2049.1 2390.7 2405.2 2422.2 2427.3 2306.5 2362.5 2366.6 2385.7 2387.6 2388.0 2392.7 2398.4 2424.7 2427.8 2386.5 2393.1 2403.1 2404.4 2416.8 9247.5 9259.5 9261.2 9276.1 9318.1 5295.9 5397.8 5437.5 5441.0 5449.5 3389.8 3472.8 3512.1 3544.7 3574.2 1052.6 1057.3 1057.4 1081.9 1091.5 12998.3 13156.9 13193.4 13198.1 13214.7 4607.7 4719.6 4818.9 4864.5 4881.4 11061.3 11068.3 11068.7 11069.0 11072.8 5366.8 5377.2 5383.8 5385.4 5387.8 4910.9 4960.6 4972.7 4997.1 5083.7 3827.5 3868.3 3891.8 3925.9 4049.9 1205.9 1282.4 1285.6 1289.9 1334.5 860.3 860.7 958.2 969.3 971.8 5851.9 6101.7 6163.0 6201.5 6390.3 995.6 998.5 1032.5 1035.0 1035.1 4289.7 4365.3 4417.4 4436.1 4447.6 10941.8 11265.5 11461.5 11480.4 11500.5 10197.7 11250.9 11646.8 11667.4 11690.2 8079.2 8421.9 8433.5 8604.9 8629.3 6336.7 6475.6 6562.1 6625.3 6646.9 10563.2 10621.6 10635.7 10684.9 10799.5 10338.0 10672.1 10947.8 10989.6 11059.8 7865.8 8329.2 8470.9 8532.6 8537.8 8822.9 9190.9 9204.6 9213.4 9235.8 8037.2 8214.2 8234.5 8292.8 8387.2 8021.8 8034.7 8149.1 8215.9 8219.6 7509.9 7536.1 7580.0 7597.4 7615.8 5568.4 5614.7 5658.1 5663.5 5770.1 5142.7 5376.2 5437.8 5641.9 5790.2 16:02:48 INFO - PROCESS | 17988 | 16:02:48 INFO - PROCESS | 17988 | [#4] prototype.html Cycles:180 Average:4684.43 Median:5287.72 stddev:1372.41 (26.0%) stddev-sans-first:1336.87 16:02:48 INFO - PROCESS | 17988 | Values: 335.5 336.2 345.8 346.4 349.1 5180.4 5278.0 5349.1 5387.3 5404.7 5257.8 5275.4 5285.7 5289.8 5315.2 4180.4 4196.0 4200.7 4212.3 4222.3 4024.9 4043.4 4152.0 4240.5 4273.4 4185.6 4203.0 4225.5 4234.4 4244.7 4199.8 4214.9 4223.1 4228.9 4232.8 3666.3 3718.7 3763.2 3763.9 3779.2 5132.9 5134.8 5136.5 5143.2 5160.3 4787.4 4793.7 4804.9 4825.3 4829.5 5386.8 5547.6 5551.2 5554.8 5608.9 4032.4 4034.6 4035.2 4035.2 4045.0 5750.4 5797.4 5834.1 5847.2 5848.8 3958.0 4120.5 4130.6 4141.0 4150.1 4170.9 4181.3 4183.4 4193.3 4199.5 4741.1 4744.6 4771.6 4777.0 4792.8 5520.7 5577.4 5595.4 5625.4 5679.6 1355.3 1386.9 1434.9 1437.4 1438.5 963.2 977.6 985.5 991.3 1003.1 5272.9 5313.5 5313.8 5313.9 5330.6 5564.1 5567.3 5599.8 5635.4 5662.0 5119.9 5348.9 5363.1 5397.3 5412.2 2712.7 2720.9 2733.8 2763.5 2772.9 5099.8 5202.9 5208.9 5219.8 5259.5 5154.6 5483.8 5849.2 5852.6 5861.9 5883.9 5948.6 5957.5 5966.2 5981.0 5524.4 5749.3 5785.5 5794.0 5832.4 5664.5 5701.2 5704.0 5707.7 5714.5 5906.9 5948.9 5972.2 5989.9 5999.9 3914.9 4087.8 4128.2 4148.2 4176.7 5603.4 5707.8 5819.8 5828.7 5861.9 5471.3 5591.7 5597.4 5609.7 5622.4 5582.3 5588.6 5596.9 5630.2 5640.3 5282.7 5501.9 5525.9 5526.1 5532.3 5591.7 5623.6 5638.4 5640.8 5659.6 5246.6 5502.4 5511.8 5535.5 5574.6 16:02:48 INFO - PROCESS | 17988 | 16:02:48 INFO - PROCESS | 17988 | [#5] yui.html Cycles:180 Average:21331.02 Median:4701.51 stddev:30908.38 (657.4%) stddev-sans-first:30956.48 16:02:48 INFO - PROCESS | 17988 | Values: 757.3 821.1 841.9 844.4 862.2 16620.4 16684.9 16975.2 17259.7 17280.7 15339.2 15346.0 15489.8 15514.3 15518.7 670.1 800.9 807.1 823.3 826.5 810.3 834.9 834.9 835.6 835.8 857.4 862.0 862.9 862.9 863.1 685.7 839.1 848.4 853.5 856.3 621.8 622.0 622.2 622.4 622.7 14795.6 14889.9 14914.8 14918.4 14937.8 14440.5 14630.3 14655.8 14871.0 14876.9 13339.9 13387.3 13569.3 13609.5 13797.7 4613.1 4628.4 4661.4 4813.4 4838.3 72581.0 73019.6 73565.6 76576.6 78090.2 11203.1 11287.9 11356.1 11404.0 11732.9 20345.7 20403.7 20491.5 20502.9 20515.0 8869.9 9190.6 9209.5 9340.5 9342.9 4982.2 4986.9 5006.9 5101.4 5269.1 3542.5 3659.3 3661.0 3665.4 3669.5 659.8 663.5 672.8 679.7 680.3 637.4 730.6 733.3 759.7 786.4 9818.2 10104.6 10179.1 10204.8 10631.2 681.7 688.4 725.1 731.2 735.3 4741.6 4814.3 4903.3 4955.1 4955.7 115533.0 116514.0 117870.0 118106.0 120380.4 99147.5 101453.0 101461.0 102425.5 103484.5 90925.0 91775.5 91890.0 92540.1 92840.5 9255.4 9284.9 9293.7 9398.9 9595.4 55404.4 56390.7 56771.0 57007.0 58862.4 73178.0 77537.0 77700.2 78673.0 79207.6 12198.8 12300.8 12525.1 12837.9 12853.1 13212.3 13457.9 13568.0 13677.2 13852.5 13118.7 13166.9 13444.3 13769.2 13838.2 12673.9 12716.7 12926.5 12983.5 12992.8 11844.8 11956.2 12219.8 12226.8 12284.0 10826.4 11006.7 11105.9 11297.4 11491.0 10082.3 10917.5 10951.9 10960.7 11019.0 16:02:48 INFO - PROCESS | 17988 | -------- Summary: end -------- 16:02:48 INFO - PROCESS | 17988 | 16:02:49 INFO - TEST-INFO | 17988: exit 0 16:02:49 INFO - TEST-OK | dromaeo_css | took 1113776ms 16:02:49 INFO - TEST-START | kraken 16:02:49 INFO - operating with platform_type : linux_ 16:02:49 INFO - Initialising browser for kraken test... 16:02:49 INFO - TEST-INFO | started process 18178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFfWyPf/profile http://localhost:42027/getInfo.html) 16:02:53 INFO - PROCESS | 18178 | __metrics Screen width/height:1600/1200 16:02:53 INFO - PROCESS | 18178 | colorDepth:24 16:02:53 INFO - PROCESS | 18178 | Browser inner width/height: 1024/697 16:02:53 INFO - PROCESS | 18178 | __metrics 16:02:54 INFO - PROCESS | 18178 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:02:55 INFO - TEST-INFO | 18178: exit 0 16:02:55 INFO - Browser initialized. 16:02:55 INFO - Running cycle 1/1 for kraken test... 16:02:55 INFO - TEST-INFO | started process 18260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFfWyPf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:07 INFO - PROCESS | 18260 | RSS: Main: 156434432 16:03:07 INFO - PROCESS | 18260 | 16:03:09 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42027/tests/kraken/driver.html?testName=audio-beat-detection) 16:03:10 INFO - PROCESS | 18260 | RSS: Main: 215318528 16:03:10 INFO - PROCESS | 18260 | 16:03:13 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42027/tests/kraken/driver.html?testName=audio-dft) 16:03:13 INFO - PROCESS | 18260 | RSS: Main: 203104256 16:03:13 INFO - PROCESS | 18260 | 16:03:16 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42027/tests/kraken/driver.html?testName=audio-fft) 16:03:17 INFO - PROCESS | 18260 | RSS: Main: 269340672 16:03:17 INFO - PROCESS | 18260 | 16:03:19 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42027/tests/kraken/driver.html?testName=audio-oscillator) 16:03:20 INFO - PROCESS | 18260 | RSS: Main: 180162560 16:03:20 INFO - PROCESS | 18260 | 16:03:22 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:03:22 INFO - PROCESS | 18260 | RSS: Main: 184762368 16:03:22 INFO - PROCESS | 18260 | 16:03:25 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42027/tests/kraken/driver.html?testName=imaging-darkroom) 16:03:26 INFO - PROCESS | 18260 | RSS: Main: 219619328 16:03:26 INFO - PROCESS | 18260 | 16:03:29 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42027/tests/kraken/driver.html?testName=imaging-desaturate) 16:03:30 INFO - PROCESS | 18260 | RSS: Main: 221798400 16:03:30 INFO - PROCESS | 18260 | 16:03:33 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42027/tests/kraken/driver.html?testName=json-parse-financial) 16:03:33 INFO - PROCESS | 18260 | RSS: Main: 221220864 16:03:33 INFO - PROCESS | 18260 | 16:03:35 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:03:35 INFO - PROCESS | 18260 | RSS: Main: 209018880 16:03:35 INFO - PROCESS | 18260 | 16:03:37 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42027/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:38 INFO - PROCESS | 18260 | RSS: Main: 214716416 16:03:38 INFO - PROCESS | 18260 | 16:03:40 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:41 INFO - PROCESS | 18260 | RSS: Main: 212099072 16:03:41 INFO - PROCESS | 18260 | 16:03:43 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:03:44 INFO - PROCESS | 18260 | RSS: Main: 224133120 16:03:44 INFO - PROCESS | 18260 | 16:03:46 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:03:47 INFO - PROCESS | 18260 | RSS: Main: 224231424 16:03:47 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:42027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42027/tests/kraken/driver.html?testName=ai-astar) 16:03:49 INFO - PROCESS | 18260 | RSS: Main: 267796480 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | __start_tp_report 16:03:49 INFO - PROCESS | 18260 | _x_x_mozilla_page_load 16:03:49 INFO - PROCESS | 18260 | _x_x_mozilla_page_load_details 16:03:49 INFO - PROCESS | 18260 | |i|pagename|runs| 16:03:49 INFO - PROCESS | 18260 | |0;ai-astar;101;113;109;109;111;111;110;111;110;112 16:03:49 INFO - PROCESS | 18260 | |1;audio-beat-detection;153;119;119;179;117;117;143;117;163;117 16:03:49 INFO - PROCESS | 18260 | |2;audio-dft;160;162;162;162;162;160;162;161;161;159 16:03:49 INFO - PROCESS | 18260 | |3;audio-fft;75;75;75;122;75;86;75;76;110;76 16:03:49 INFO - PROCESS | 18260 | |4;audio-oscillator;83;82;108;82;84;83;134;83;84;128 16:03:49 INFO - PROCESS | 18260 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;116;117;117 16:03:49 INFO - PROCESS | 18260 | |6;imaging-darkroom;146;145;146;147;146;145;146;146;145;145 16:03:49 INFO - PROCESS | 18260 | |7;imaging-desaturate;95;94;94;95;95;95;95;95;95;95 16:03:49 INFO - PROCESS | 18260 | |8;json-parse-financial;53;52;53;52;55;54;54;52;52;54 16:03:49 INFO - PROCESS | 18260 | |9;json-stringify-tinderbox;61;61;61;61;62;61;61;60;61;61 16:03:49 INFO - PROCESS | 18260 | |10;stanford-crypto-aes;83;80;75;75;74;75;75;74;75;74 16:03:49 INFO - PROCESS | 18260 | |11;stanford-crypto-ccm;119;129;132;136;117;118;125;121;170;120 16:03:49 INFO - PROCESS | 18260 | |12;stanford-crypto-pbkdf2;156;159;153;155;162;152;160;152;160;159 16:03:49 INFO - PROCESS | 18260 | |13;stanford-crypto-sha256-iterative;62;62;63;62;62;64;61;65;61;62 16:03:49 INFO - PROCESS | 18260 | __end_tp_report 16:03:49 INFO - PROCESS | 18260 | __start_cc_report 16:03:49 INFO - PROCESS | 18260 | _x_x_mozilla_cycle_collect,1645 16:03:49 INFO - PROCESS | 18260 | __end_cc_report 16:03:49 INFO - PROCESS | 18260 | __startTimestamp1467327829327__endTimestamp 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | ------- Summary: start ------- 16:03:49 INFO - PROCESS | 18260 | Number of tests: 14 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.30 (3.0%) stddev-sans-first:1.32 16:03:49 INFO - PROCESS | 18260 | Values: 101.0 113.0 109.0 109.0 111.0 111.0 110.0 111.0 110.0 112.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:131.00 stddev:23.36 (17.8%) stddev-sans-first:23.79 16:03:49 INFO - PROCESS | 18260 | Values: 153.0 119.0 119.0 179.0 117.0 117.0 143.0 117.0 163.0 117.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 16:03:49 INFO - PROCESS | 18260 | Values: 160.0 162.0 162.0 162.0 162.0 160.0 162.0 161.0 161.0 159.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#3] audio-fft Cycles:10 Average:84.50 Median:75.00 stddev:17.17 (22.9%) stddev-sans-first:17.87 16:03:49 INFO - PROCESS | 18260 | Values: 75.0 75.0 75.0 122.0 75.0 86.0 75.0 76.0 110.0 76.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.00 stddev:20.52 (24.7%) stddev-sans-first:21.30 16:03:49 INFO - PROCESS | 18260 | Values: 83.0 82.0 108.0 82.0 84.0 83.0 134.0 83.0 84.0 128.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:03:49 INFO - PROCESS | 18260 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:03:49 INFO - PROCESS | 18260 | Values: 146.0 145.0 146.0 147.0 146.0 145.0 146.0 146.0 145.0 145.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:03:49 INFO - PROCESS | 18260 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.50 stddev:1.10 (2.1%) stddev-sans-first:1.17 16:03:49 INFO - PROCESS | 18260 | Values: 53.0 52.0 53.0 52.0 55.0 54.0 54.0 52.0 52.0 54.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 16:03:49 INFO - PROCESS | 18260 | Values: 61.0 61.0 61.0 61.0 62.0 61.0 61.0 60.0 61.0 61.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.00 stddev:3.02 (4.0%) stddev-sans-first:1.86 16:03:49 INFO - PROCESS | 18260 | Values: 83.0 80.0 75.0 75.0 74.0 75.0 75.0 74.0 75.0 74.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:127.00 stddev:15.86 (12.5%) stddev-sans-first:16.43 16:03:49 INFO - PROCESS | 18260 | Values: 119.0 129.0 132.0 136.0 117.0 118.0 125.0 121.0 170.0 120.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:159.00 stddev:3.68 (2.3%) stddev-sans-first:3.89 16:03:49 INFO - PROCESS | 18260 | Values: 156.0 159.0 153.0 155.0 162.0 152.0 160.0 152.0 160.0 159.0 16:03:49 INFO - PROCESS | 18260 | 16:03:49 INFO - PROCESS | 18260 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.26 (2.0%) stddev-sans-first:1.33 16:03:49 INFO - PROCESS | 18260 | Values: 62.0 62.0 63.0 62.0 62.0 64.0 61.0 65.0 61.0 62.0 16:03:49 INFO - PROCESS | 18260 | -------- Summary: end -------- 16:03:49 INFO - PROCESS | 18260 | 16:03:50 INFO - TEST-INFO | 18260: exit 0 16:03:50 INFO - TEST-OK | kraken | took 60758ms 16:03:50 INFO - SUITE-END | took 1174s 16:03:50 INFO - Completed test suite (00:19:34) 16:03:50 INFO - javascript benchmark 16:03:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.7976031557932, 3116.3455674308398, 3136.1375621704024, 3156.1005113542647, 3176.332970076284, 5263.921041184385, 5323.707196104213, 5374.758135883885, 5424.728763561821, 5425.213344065113, 5345.33183352081, 5347.197920311945, 5357.357117145948, 5357.866053348658, 5388.9191662125, 4811.302361157639, 4874.805007799684, 4889.584385327252, 4895.0454661341055, 5076.187809950408, 4938.432080310774, 4956.231784073474, 5010.674306170087, 5025.3718285214345, 5028.7988480460735, 4801.303810947411, 4853.344798452216, 4896.216605343128, 4914.213725803854, 4915.754212289389, 4886.096072226649, 4911.336969509106, 4979.45226025137, 4982.476839931791, 5025.271335656309, 4803.063402636487, 4937.259411088329, 4943.283223932545, 4957.925631115536, 4978.900421991576, 5337.039332920072, 5422.91865622016, 5431.21247419122, 5476.397596264408, 5490.0, 5848.0, 5863.205172302043, 5873.823785286449, 5889.911651325191, 5897.32180799205, 5684.7157642118145, 5714.228579141804, 5800.042992906166, 5881.588288819784, 5882.499987501067, 5346.91979620306, 5368.221607866837, 5436.184572314145, 5442.265294185314, 5442.510174084312, 5914.6746928918465, 5920.141579470953, 5921.940780592139, 5922.437368449991, 5925.318588362307, 5581.190727344512, 5619.578531610146, 5659.0, 5696.686682232517, 5699.373068962411, 5834.912476312858, 5850.444207800252, 5854.853628659318, 5856.8535786604825, 5857.209276747584, 5744.253247077937, 5783.392743761929, 5789.073748200268, 5791.044477661138, 5830.708464576839, 5581.330240371181, 5740.56945729072, 5772.913406298909, 5783.913241301384, 5799.594028417971, 4444.4888837784065, 4446.510883802779, 4446.510883802779, 4448.132614140276, 4478.14915166124, 3970.7419017763755, 3982.5818289079807, 3993.2213218422708, 3994.9001274967777, 4024.7182697210915, 5328.520433161034, 5365.007473617393, 5380.031594313061, 5444.945550544523, 5455.563554915597, 5721.856953576111, 5750.482456578844, 5751.971240143773, 5770.221020162225, 5806.506446952057, 5456.290682211366, 5465.0, 5473.616846820764, 5474.7810087596845, 5475.4524547544925, 4891.926621100686, 4902.117618828645, 4929.556339929423, 4940.036692844861, 4968.453470118284, 5905.793297234576, 5907.8227653169615, 5908.291005079418, 5915.733791979371, 5925.792597259076, 5640.492355688008, 5669.121286200645, 5674.517665998436, 5691.0040742869005, 5697.145428185805, 5946.583739138392, 5963.075723262901, 5985.790497332572, 6033.758649653964, 6034.668093254913, 5669.092945128759, 5716.685582292847, 5726.2269593606, 5728.971355143364, 5736.110902810071, 5545.750441230235, 5749.425057494217, 5799.449052340021, 5821.243238378984, 5836.533077353886, 5625.437456254342, 5679.716014199356, 5698.2592263005545, 5703.344115426779, 5752.712364381848, 5625.634333768292, 5664.065429204135, 5672.858178545569, 5675.4892059713175, 5709.371969083314, 5387.946120538902, 5458.426865179099, 5489.835304940858, 5598.86002849932, 5614.85962850932, 5645.435456454322, 5651.406602306699, 5676.347220069745, 5703.7433315500075, 5705.857353566028, 5522.917156242579, 5523.917141242804, 5532.861678458071, 5534.612577119724, 5538.0], "value": 5326.495620078254, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.3557504532536, 617.9258488981322, 620.667942650682, 628.2523796681951, 640.5228105061728, 32756.836215818916, 35772.64227357726, 43134.13731725363, 43965.560344396545, 44003.77998110005, 45751.77124114383, 46152.0, 46205.0, 46219.76890115545, 46300.0, 8957.865632015524, 9112.498812565307, 9113.3165012624, 9117.316201284897, 9124.543772811367, 8802.603882825257, 8891.0, 8895.510746908918, 8898.154675305836, 8899.95550022249, 8889.599968001423, 8915.331350148732, 8941.016488186295, 8942.284617230605, 8942.687005954793, 8858.11418858109, 8904.554772261361, 8905.376623636315, 8919.28645708345, 8947.060558641346, 8897.777555561162, 8942.46345219289, 8952.686655967074, 8965.506897120657, 8967.686130985385, 44139.11721765547, 44471.11057778859, 44521.77739111316, 44541.77729111366, 44806.55193448089, 3863.459115723801, 3880.1463677990796, 3945.7237993340477, 3966.3058964681063, 4438.090191510732, 32935.50596741051, 33226.50480728373, 33231.169220769436, 33878.66121338804, 34756.47865282023, 4167.624913757776, 4182.2890108681295, 4229.0, 4278.529361770203, 4437.778111094464, 374733.0, 375467.0, 378050.4267222649, 378114.0, 381710.0, 37259.62740372616, 38278.61721382751, 60472.0, 61077.694611526655, 61212.69393653092, 40139.59860401417, 40178.39732404016, 40266.79866600707, 40284.0, 40307.395389069185, 15640.296186671627, 15758.290876910567, 15770.60573485649, 15783.526494205193, 15790.131542765028, 13089.0, 13131.34343282832, 13135.540256090992, 13139.934300328438, 13155.73688526224, 9061.456312621263, 9135.634574617074, 9147.95426022879, 9187.08129187076, 9200.263978881674, 3406.4890266459734, 3480.6693364130365, 3492.650734926487, 3496.930061398758, 3509.6312438149143, 1001.9562475795171, 1022.1669339488442, 1084.6637542361893, 1120.1654767198327, 1134.9902267493476, 33227.0, 33852.830735846655, 33928.660713393045, 34132.0, 34406.0, 1100.6422912553453, 1126.6169502369235, 1135.2620796482352, 1149.2472430557998, 1159.6984783956232, 17591.912040439714, 17830.37593684215, 17843.375481858333, 17981.640367192584, 17993.19030643624, 574836.0, 575282.0, 577952.0, 579446.0, 581717.0, 62417.37582624116, 63103.68448157822, 63114.36885631085, 63196.36803631997, 63214.68392658007, 1244.1601918705019, 1268.9175203611735, 1287.5622288421794, 1303.6219496345952, 1340.035174674233, 30750.384992300475, 34717.65282347144, 34923.0, 35296.82351588226, 35384.0, 55625.721871390386, 56475.15287270612, 56682.716586416806, 56708.14937775854, 56766.0, 512867.0, 524586.0, 525050.0, 527147.0, 527416.0, 45688.54311456843, 47012.52987470081, 47576.524234757206, 47867.52132478631, 47876.28185577289, 51833.74083129711, 52148.739256303474, 52455.21317180169, 52622.0, 53411.0, 43055.0, 43299.567004329554, 43491.0, 44523.0, 44959.55040449554, 43836.0, 44019.0, 44058.0, 44455.0, 45216.32175517436, 42940.35589466223, 43734.56265437305, 44175.77912110547, 44355.77822110869, 44363.55636443723, 35715.46426803548, 38755.61244387633, 39228.080687038375, 39304.58360747313, 39834.20331593294, 28572.285692857844, 28900.855495723226, 29166.770818230812, 29314.560281595368, 29486.705132948395], "value": 20025.64993210186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.5368934123723, 408.23863494582605, 410.784338222433, 415.738085006446, 433.3175248982853, 15752.763708544368, 19372.70940935887, 19881.105350259237, 20001.59996800063, 21755.23856665017, 17996.55008624785, 18001.54996125094, 18269.908650456728, 18311.267549298012, 19917.30289439866, 5656.349519805213, 5720.2849643794425, 5905.822825315247, 5908.438698323674, 5934.28788545373, 5772.0476121439915, 5820.0, 5820.912686309709, 5828.766849326022, 5850.73671684773, 5604.8038318658855, 5805.274340707411, 5853.356130825606, 5859.29688437386, 5864.091065884794, 5785.623934444268, 5789.218455508494, 5796.304443466769, 5797.971010144944, 5801.53587712982, 5180.922286165711, 5491.615586908918, 5497.697626630534, 5576.470235327637, 5586.050371436865, 14187.219702916336, 14468.059576127518, 19929.701054484194, 23522.176723814755, 24788.25635230946, 2354.21133920137, 2367.7040369953756, 2462.938426539333, 2535.0873685473216, 2538.0989748639336, 10834.295770774954, 12431.75136497274, 12518.937405313007, 15182.316795744107, 15578.221088945507, 1913.3972798568545, 1958.4614231086423, 1972.3195497553465, 1975.980240197594, 1988.721578978944, 49918.7504062481, 62842.0, 66261.66869165671, 79831.600841996, 92595.0, 10760.946195268974, 11425.371604561662, 11517.366544840113, 11520.88479115198, 11888.940555297168, 16056.27746751399, 16302.673946521003, 16325.673486530202, 16339.509814705578, 16355.509334719978, 8459.534725590152, 8554.572271386405, 8584.934888415864, 8607.827843443221, 8791.868121978176, 8274.875876861852, 8357.58212089393, 8436.662533498715, 8459.534725590152, 8470.872936905951, 4828.903421931542, 4928.457869634337, 4972.7513624318635, 4986.850394488171, 5069.5437410632485, 2037.113855472874, 2065.9380218593465, 2071.181883156145, 2093.216022689819, 2099.9160033598487, 897.3359713811863, 937.5640327247862, 1022.2384323678907, 1053.546974800843, 1056.8467572201987, 19738.0, 20126.29557965464, 20611.69082463764, 21027.0, 21337.89331053335, 1015.7816069545083, 1022.6471867205802, 1045.137761346892, 1080.1628737728324, 1084.0947808579924, 10956.561737530568, 11638.825417618742, 11869.406529673483, 11873.0, 11890.702732431586, 440946.0, 443152.0, 505412.0, 518118.0, 519607.0, 56280.43719562752, 90414.0, 99865.50067249617, 100029.0, 100286.0, 934.9953250233841, 985.4284514981293, 1016.5273147986222, 1029.583018877356, 1033.395463653771, 18756.0, 18787.812121878607, 19153.425397238105, 19204.71192932135, 19222.903885480482, 39525.80237098796, 44293.55706442894, 44557.61424741218, 45536.77231613821, 45975.31037034514, 59123.40876591351, 59275.40724592699, 59894.70052649709, 60362.69818650879, 61538.076928847, 8771.956140219258, 8885.333599979898, 9075.863862042206, 9116.544172791466, 9181.173694367539, 13426.597202083953, 13954.860451395356, 13992.510262140777, 14082.155070695791, 14165.43338266499, 11995.700107497034, 12129.0, 12232.449539770554, 12630.179038362478, 12942.547010854574, 12047.698807529881, 12380.133390662568, 12400.19398739079, 12433.756624337493, 12553.811692824433, 12117.15179937396, 12305.753884922073, 12438.0, 12469.75060498803, 12506.18709783861, 8597.140285971353, 9054.27565794748, 9197.126273004054, 9240.768980775534, 9272.768180795534, 11390.886091138982, 11748.471318790846, 12122.878771212529, 12236.143469957018, 12600.0], "value": 9497.519042545347, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.9258537073147, 1520.92395380231, 1646.7941507311587, 1788.4724006418105, 1820.4447643468745, 8756.255718263947, 9371.765705857357, 9454.385464944791, 9461.0, 9461.19579835714, 8059.959700201505, 8793.95603021984, 9041.457512549252, 9069.319801014934, 9283.118103780147, 2368.8341816072925, 2390.414348484615, 2397.328747950568, 2398.688170537828, 2398.8080953523763, 2049.077914938276, 2390.725066617344, 2405.2423486601665, 2422.236995346469, 2427.3082171581104, 2306.4925716342377, 2362.48025434405, 2366.5858474766933, 2385.654080158376, 2387.6299173628026, 2388.0209114263157, 2392.7009123859516, 2398.3764221302413, 2424.709034915804, 2427.7936375407935, 2386.474975505386, 2393.102586530051, 2403.146882856578, 2404.362843846382, 2416.8066554675584, 9247.537623118817, 9259.490728009956, 9261.166495015414, 9276.11876871696, 9318.068193180628, 5295.894082118374, 5397.8380648580605, 5437.510624043855, 5441.0, 5449.482299181611, 3389.813560254185, 3472.8365997390906, 3512.121969507623, 3544.6632569906074, 3574.2136729919375, 1052.6052730226165, 1057.2810488867567, 1057.428988346292, 1081.9134469242442, 1091.5251865438559, 12998.285094319808, 13156.934215328862, 13193.40629671667, 13198.14212076212, 13214.66963325915, 4607.654425918069, 4719.622430205575, 4818.903621927542, 4864.464908860023, 4881.414230292387, 11061.336319820837, 11068.28056176346, 11068.723281918017, 11069.0, 11072.833907491395, 5366.812161574404, 5377.193420986805, 5383.81156659515, 5385.380681221632, 5387.81142660005, 4910.926336104962, 4960.627952903546, 4972.651914366032, 4997.0505603935135, 5083.669561478492, 3827.5215598050245, 3868.323043467382, 3891.785951772623, 3925.8822235332987, 4049.8987525311513, 1205.879412058787, 1282.4229096906429, 1285.607889593683, 1289.8581156072823, 1334.4928927007675, 860.3481315873538, 860.7159637319669, 958.2382006305004, 969.2972594868663, 971.7522031881825, 5851.853703657357, 6101.664408457489, 6163.0, 6201.534884883652, 6390.30491481418, 995.5868314649484, 998.4558415663481, 1032.488917985602, 1035.0477560644226, 1035.1201478743008, 4289.656827453796, 4365.323374876899, 4417.447819022622, 4436.112777444524, 4447.599716025573, 10941.781164376827, 11265.549378024787, 11461.484233209525, 11480.368579728196, 11500.482478288497, 10197.694069177936, 11250.943745281385, 11646.825297620542, 11667.416629168507, 11690.181687281809, 8079.1516890725625, 8421.915780842113, 8433.536155511505, 8604.8709269361, 8629.309655227567, 6336.7465301389275, 6475.611463312216, 6562.114114594468, 6625.337466253336, 6646.90029649546, 10563.20775941792, 10621.575136994743, 10635.734106647396, 10684.946575267073, 10799.514021869192, 10338.0, 10672.146228301563, 10947.83578246343, 10989.560417583527, 11059.778804424028, 7865.764027079197, 8329.208725171098, 8470.915290847259, 8532.573371331284, 8537.786555335917, 8822.867656985021, 9190.908090919005, 9204.631814727603, 9213.401128926598, 9235.76910577241, 8037.23646253605, 8214.219649133562, 8234.505929644241, 8292.792680183044, 8387.161283871565, 8021.799455013438, 8034.67861285542, 8149.062857771195, 8215.876761848696, 8219.589020549069, 7509.9249007509225, 7536.057992750906, 7579.962100189464, 7597.354224890946, 7615.771526853981, 5568.443155684399, 5614.718270682752, 5658.122990936411, 5663.461971112738, 5770.105633626795, 5142.717150556755, 5376.166694162411, 5437.782488700408, 5641.915371269352, 5790.189373487631], "value": 4839.186040676143, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.4529354598419, 336.18642884220185, 345.7735183454838, 346.37825103938434, 349.14982018784247, 5180.404253510838, 5278.0, 5349.090654588719, 5387.272718183049, 5404.729763511824, 5257.789688412459, 5275.36695596529, 5285.656432331895, 5289.788408463657, 5315.202719592054, 4180.352045432963, 4196.0, 4200.663946884242, 4212.262854000553, 4222.324428091506, 4024.859129930453, 4043.4339192512925, 4152.0, 4240.469941257343, 4273.380359847836, 4185.560516145792, 4203.0, 4225.471816022997, 4234.449521562193, 4244.662931176685, 4199.7690127043, 4214.852480163179, 4223.092035212444, 4228.936565951513, 4232.76719780412, 3666.2850744104912, 3718.665320121202, 3763.153290509641, 3763.9247215055548, 3779.2063666630042, 5132.871678208037, 5134.768935397916, 5136.484737002594, 5143.177091665353, 5160.277561141444, 4787.449443314029, 4793.71237725734, 4804.927926081112, 4825.311141100622, 4829.492903245144, 5386.8383948481605, 5547.55619550435, 5551.2228288039705, 5554.80585168856, 5608.859778505529, 4032.3548232282988, 4034.6167114124405, 4035.1929614077007, 4035.233305671913, 4045.02919299369, 5750.3962083981, 5797.449242321973, 5834.095715164156, 5847.152162936393, 5848.824535263949, 3957.960420395817, 4120.464339635828, 4130.648894843912, 4140.956397048167, 4150.066235097079, 4170.895727606834, 4181.310083836133, 4183.410304084428, 4193.308104162779, 4199.538050814408, 4741.099191153669, 4744.620430365562, 4771.642126840501, 4776.9761151194025, 4792.808287668524, 5520.66875987442, 5577.44225577439, 5595.38450770415, 5625.409332020161, 5679.602427830095, 1355.2884735513935, 1386.9029167958347, 1434.8852091832628, 1437.4034775568023, 1438.4821464272854, 963.1572374172599, 977.6040703515088, 985.522021819417, 991.3011327014437, 1003.0972125087479, 5272.868178295496, 5313.521783039468, 5313.787448502017, 5313.920291195558, 5330.600204984642, 5564.10974244119, 5567.3040869891265, 5599.804006859822, 5635.408282130399, 5662.0, 5119.923201151985, 5348.893022139536, 5363.088274993261, 5397.271368365299, 5412.185663454981, 2712.742289482496, 2720.8980362953034, 2733.8223015503927, 2763.5301998660275, 2772.9306767330977, 5099.796008159707, 5202.869928251824, 5208.947910520847, 5219.765110570033, 5259.526642602108, 5154.613403994716, 5483.8080667176455, 5849.151872978395, 5852.648841069549, 5861.941380586225, 5883.882322353529, 5948.583599148104, 5957.49361304294, 5966.224390829165, 5980.970095149583, 5524.447555244444, 5749.310082790092, 5785.450382213683, 5793.971030144822, 5832.416758324303, 5664.49019588239, 5701.173329867229, 5703.971480142573, 5707.743151558273, 5714.514266287412, 5906.940930590639, 5948.910766338595, 5972.163897054329, 5989.850253743517, 5999.890020346075, 3914.9021274468364, 4087.8160482777753, 4128.236276288896, 4148.211839750437, 4176.686748493815, 5603.35561410443, 5707.800226992035, 5819.79630712923, 5828.708564571839, 5861.853453663522, 5471.2613797138465, 5591.692456914909, 5597.384287728428, 5609.653683116105, 5622.437756224344, 5582.29258809469, 5588.552915766811, 5596.86007849807, 5630.211770352236, 5640.294963129609, 5282.656627319212, 5501.944980550144, 5525.889482210414, 5526.143447765603, 5532.30846144232, 5591.692456914909, 5623.550115990629, 5638.379778224474, 5640.774369025193, 5659.603827732019, 5246.61279118008, 5502.449755024626, 5511.834644960658, 5535.501804837584, 5574.581906356958], "value": 4250.432858747524, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.2616698718749, 821.1008945204999, 841.9158084191581, 844.3667249562828, 862.1593945902746, 16620.418285359985, 16684.916575417123, 16975.15124243786, 17259.74110388345, 17280.65438691227, 15339.233038348093, 15346.0, 15489.767653485178, 15514.30185641646, 15518.68962620747, 670.128832517725, 800.8638531449639, 807.1121766057335, 823.333100188846, 826.5495305058757, 810.3031393002013, 834.9039860416038, 834.9165083491632, 835.5780330932901, 835.7701632051204, 857.4340934982913, 862.0474375814729, 862.8921384826897, 862.9266512346458, 863.080818927843, 685.746273878668, 839.1273076000952, 848.4061157189992, 853.5007020892785, 856.2935578148022, 621.8165641135876, 621.9720112594944, 622.2222222222222, 622.3558616831558, 622.7477871462065, 14795.630109247248, 14889.851101488955, 14914.776278355834, 14918.403263869432, 14937.7759333609, 14440.49458268966, 14630.341634626468, 14655.780163297559, 14871.0, 14876.925615371962, 13339.933300333436, 13387.330633468287, 13569.321533923265, 13609.455621775118, 13797.724045519033, 4613.100445413146, 4628.4445866496235, 4661.417322834645, 4813.3983252093485, 4838.274258861164, 72581.0, 73019.63490182515, 73565.63217183879, 76576.61711691461, 78090.21909780886, 11203.054116363752, 11287.943560282147, 11356.096590485256, 11404.0, 11732.94133529327, 20345.694814577793, 20403.693944590843, 20491.4877128073, 20502.897485512774, 20515.0, 8869.911300887037, 9190.63237470507, 9209.539523023823, 9340.486273255035, 9342.90657093434, 4982.153033984231, 4986.925196122061, 5006.89986200274, 5101.438841727407, 5269.051570717231, 3542.4863394807608, 3659.2864391443413, 3661.0, 3665.4135338345736, 3669.486271921933, 659.7888675623755, 663.4559661077966, 672.8351553869334, 679.6601699150425, 680.306087790451, 637.4295005969724, 730.6273800361854, 733.2740586819117, 759.7454852624322, 786.3748320085546, 9818.165455936183, 10104.595816167419, 10179.134773544332, 10204.795904081877, 10631.186078232493, 681.7068660475944, 688.3875691749821, 725.1081170160732, 731.177425396429, 735.3235023778137, 4741.596964258077, 4814.266863928983, 4903.313536104948, 4955.108080545464, 4955.677880937727, 115533.0, 116514.0, 117870.0, 118106.0, 120380.39809800895, 99147.50426247966, 101453.0, 101461.0, 102425.48787256164, 103484.48257758663, 90925.0, 91775.54112229396, 91890.0, 92540.0745992545, 92840.53579732194, 9255.398399104037, 9284.907150928404, 9293.72118836436, 9398.859017114886, 9595.376300540442, 55404.44595554154, 56390.71804640951, 56771.0, 57007.0, 58862.41137588569, 73178.0, 77537.0, 77700.22299777156, 78673.0, 79207.60396197982, 12198.817017744563, 12300.753984920431, 12525.123241373381, 12837.871621283668, 12853.100282980102, 13212.339383031001, 13457.932710336385, 13568.0, 13677.179369237878, 13852.515161969282, 13118.672033199246, 13166.934165329112, 13444.327783610976, 13769.173849569059, 13838.169709817443, 12673.93663031716, 12716.745665086832, 12926.482940682268, 12983.545575904798, 12992.805107923577, 11844.76310473803, 11956.222845515014, 12219.816702749644, 12226.813955336396, 12284.0, 10826.350418974887, 11006.716756040989, 11105.888941110485, 11297.378644174649, 11491.035592720498, 10082.344647597884, 10917.508712107816, 10951.890481095406, 10960.671179864617, 11019.0], "value": 7711.237402441088, "unit": "score"}], "name": "dromaeo_css", "value": 7373.413952578921, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 109.0, 109.0, 111.0, 111.0, 110.0, 111.0, 110.0, 112.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 119.0, 179.0, 117.0, 117.0, 143.0, 117.0, 163.0, 117.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 162.0, 162.0, 160.0, 162.0, 161.0, 161.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 122.0, 75.0, 86.0, 75.0, 76.0, 110.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 82.0, 84.0, 83.0, 134.0, 83.0, 84.0, 128.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 55.0, 54.0, 54.0, 52.0, 52.0, 54.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 75.0, 75.0, 74.0, 75.0, 75.0, 74.0, 75.0, 74.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 129.0, 132.0, 136.0, 117.0, 118.0, 125.0, 121.0, 170.0, 120.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 153.0, 155.0, 162.0, 152.0, 160.0, 152.0, 160.0, 159.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 64.0, 61.0, 65.0, 61.0, 62.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1480.1, "alertThreshold": 2.0}]} 16:03:50 INFO - Return code: 0 16:03:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:03:50 INFO - # TBPL SUCCESS # 16:03:50 INFO - Running post-action listener: _resource_record_post_action 16:03:50 INFO - ##### 16:03:50 INFO - ##### Finished run-tests step (success) 16:03:50 INFO - ##### 16:03:50 INFO - Running post-run listener: _resource_record_post_run 16:03:50 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 556953600; Read time: 196; Write time: 822828 16:03:50 INFO - TinderboxPrint: CPU usage
13.0% 16:03:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 196 16:03:50 INFO - TinderboxPrint: I/O write bytes / time
556,953,600 / 822,828 16:03:50 INFO - TinderboxPrint: CPU idle
8,273.0 (87.0%) 16:03:50 INFO - TinderboxPrint: CPU user
1,194.9 (12.6%) 16:03:50 INFO - TinderboxPrint: Swap in / out
0 / 0 16:03:50 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 256110592; Read time: 0; Write time: 511068 16:03:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296824832; Read time: 196; Write time: 310896 16:03:51 INFO - Running post-run listener: _upload_blobber_files 16:03:51 INFO - Blob upload gear active. 16:03:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:03:51 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 16:03:51 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:03:51 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:03:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:03:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:03:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:03:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:52 INFO - (blobuploader) - INFO - Done attempting. 16:03:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:03:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:03:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:53 INFO - (blobuploader) - INFO - Done attempting. 16:03:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:03:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:03:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:57 INFO - (blobuploader) - INFO - Done attempting. 16:03:57 INFO - (blobuploader) - INFO - Iteration through files over. 16:03:57 INFO - Return code: 0 16:03:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:03:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:03:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2d8a22bcfcb0148a6ea72241c0e1a6bd7fbb747777708af38b064d2889a50e827bc00438dbbf0ac01e2956869b764a730fc5e29a155492d80c6ba60bb4065136", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b632a6fda346627fb506deb400d3826e13e8705dedcb793ae565fdee4f5ccf23267250f11e94b0fcd66cceda47d237df1e6589f5abf74ca71871cbe50c09596a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ddb0a7f2ee645c39018e98a4e3de43187caecf6309f9fafd48bdbc71191d2d251715f8941a88252ff2d2113b7c4f6d91f9630a11c5f4da5573671eb9946a3a1f"} 16:03:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:03:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:03:57 INFO - Contents: 16:03:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2d8a22bcfcb0148a6ea72241c0e1a6bd7fbb747777708af38b064d2889a50e827bc00438dbbf0ac01e2956869b764a730fc5e29a155492d80c6ba60bb4065136", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b632a6fda346627fb506deb400d3826e13e8705dedcb793ae565fdee4f5ccf23267250f11e94b0fcd66cceda47d237df1e6589f5abf74ca71871cbe50c09596a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ddb0a7f2ee645c39018e98a4e3de43187caecf6309f9fafd48bdbc71191d2d251715f8941a88252ff2d2113b7c4f6d91f9630a11c5f4da5573671eb9946a3a1f"} 16:03:57 INFO - Running post-run listener: copy_logs_to_upload_dir 16:03:57 INFO - Copying logs to upload dir... 16:03:57 INFO - mkdir: /builds/slave/test/build/upload/logs 16:03:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.593923 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-30 16:03:56.839628) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:03:56.842922) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2d8a22bcfcb0148a6ea72241c0e1a6bd7fbb747777708af38b064d2889a50e827bc00438dbbf0ac01e2956869b764a730fc5e29a155492d80c6ba60bb4065136", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b632a6fda346627fb506deb400d3826e13e8705dedcb793ae565fdee4f5ccf23267250f11e94b0fcd66cceda47d237df1e6589f5abf74ca71871cbe50c09596a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ddb0a7f2ee645c39018e98a4e3de43187caecf6309f9fafd48bdbc71191d2d251715f8941a88252ff2d2113b7c4f6d91f9630a11c5f4da5573671eb9946a3a1f"} build_url:https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/VHZjA3EeQ8uvZ-QK1At6Vg/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/Autoland/sha512/2d8a22bcfcb0148a6ea72241c0e1a6bd7fbb747777708af38b064d2889a50e827bc00438dbbf0ac01e2956869b764a730fc5e29a155492d80c6ba60bb4065136", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b632a6fda346627fb506deb400d3826e13e8705dedcb793ae565fdee4f5ccf23267250f11e94b0fcd66cceda47d237df1e6589f5abf74ca71871cbe50c09596a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ddb0a7f2ee645c39018e98a4e3de43187caecf6309f9fafd48bdbc71191d2d251715f8941a88252ff2d2113b7c4f6d91f9630a11c5f4da5573671eb9946a3a1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:03:56.868529) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:03:56.868880) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1467326605.236171-1176482519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:03:56.952276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:03:56.952611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:03:56.952911) ========= ========= Total master_lag: 0.16 =========