builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1469099856.29 results: success (0) buildid: 20160721013053 builduid: 5eea57702cd640139e1f7c0364126b00 revision: 79b1ba1f1f4bcc68801315438fa632e6c916549e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:36.285619) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:36.286158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:36.286451) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:36.301644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:36.302028) ========= 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=cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 04:17:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.8M=0s 2016-07-21 04:17:36 (23.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.291154 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:36.606508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:36.606835) ========= 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=cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014194 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:36.656397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:36.656756) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 79b1ba1f1f4bcc68801315438fa632e6c916549e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 79b1ba1f1f4bcc68801315438fa632e6c916549e --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=cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 04:17:37,088 truncating revision to first 12 chars 2016-07-21 04:17:37,088 Setting DEBUG logging. 2016-07-21 04:17:37,088 attempt 1/10 2016-07-21 04:17:37,088 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/79b1ba1f1f4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 04:17:37,409 unpacking tar archive at: mozilla-inbound-79b1ba1f1f4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679744 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:37.350183) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:37.350509) ========= script_repo_revision: 79b1ba1f1f4bcc68801315438fa632e6c916549e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:37.350905) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:37.351194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 04:17:37.359620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-21 04:17:37.359930) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:17:37 INFO - MultiFileLogger online at 20160721 04:17:37 in /builds/slave/test 04:17:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:17:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:17:37 INFO - {'append_to_log': False, 04:17:37 INFO - 'base_work_dir': '/builds/slave/test', 04:17:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:17:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:17:37 INFO - 'branch': 'Mozilla-Inbound', 04:17:37 INFO - 'buildbot_json_path': 'buildprops.json', 04:17:37 INFO - 'config_files': ('talos/linux_config.py',), 04:17:37 INFO - 'default_actions': ('clobber', 04:17:37 INFO - 'read-buildbot-config', 04:17:37 INFO - 'download-and-extract', 04:17:37 INFO - 'populate-webroot', 04:17:37 INFO - 'create-virtualenv', 04:17:37 INFO - 'install', 04:17:37 INFO - 'run-tests'), 04:17:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:17:37 INFO - 'download_minidump_stackwalk': True, 04:17:37 INFO - 'download_symbols': 'ondemand', 04:17:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:17:37 INFO - 'tooltool.py': '/tools/tooltool.py', 04:17:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:17:37 INFO - '/tools/misc-python/virtualenv.py')}, 04:17:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:17:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:17:37 INFO - 'installer_path': 'installer.exe', 04:17:37 INFO - 'log_level': 'info', 04:17:37 INFO - 'log_name': 'talos', 04:17:37 INFO - 'log_to_console': True, 04:17:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:17:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:17:37 INFO - 'opt_config_files': (), 04:17:37 INFO - 'pip_index': False, 04:17:37 INFO - 'sps_profile': False, 04:17:37 INFO - 'sps_profile_interval': 0, 04:17:37 INFO - 'suite': 'dromaeojs-e10s', 04:17:37 INFO - 'system_bits': '32', 04:17:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:17:37 INFO - 'title': 'talos-linux64-ix-054', 04:17:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:17:37 INFO - 'use_talos_json': True, 04:17:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:17:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:17:37 INFO - 'work_dir': 'build'} 04:17:37 INFO - [mozharness: 2016-07-21 11:17:37.882187Z] Running clobber step. 04:17:37 INFO - Running pre-action listener: _resource_record_pre_action 04:17:37 INFO - Running main action method: clobber 04:17:37 INFO - rmtree: /builds/slave/test/build 04:17:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:17:38 INFO - Running post-action listener: _resource_record_post_action 04:17:38 INFO - [mozharness: 2016-07-21 11:17:38.352733Z] Finished clobber step (success) 04:17:38 INFO - [mozharness: 2016-07-21 11:17:38.352834Z] Running read-buildbot-config step. 04:17:38 INFO - Running pre-action listener: _resource_record_pre_action 04:17:38 INFO - Running main action method: read_buildbot_config 04:17:38 INFO - Using buildbot properties: 04:17:38 INFO - { 04:17:38 INFO - "project": "", 04:17:38 INFO - "product": "firefox", 04:17:38 INFO - "script_repo_revision": "production", 04:17:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:17:38 INFO - "repository": "", 04:17:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:17:38 INFO - "buildid": "20160721013053", 04:17:38 INFO - "pgo_build": "True", 04:17:38 INFO - "basedir": "/builds/slave/test", 04:17:38 INFO - "buildnumber": 1059, 04:17:38 INFO - "slavename": "talos-linux64-ix-054", 04:17:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:17:38 INFO - "platform": "ubuntu64_hw", 04:17:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:17:38 INFO - "branch": "mozilla-inbound", 04:17:38 INFO - "repo_path": "integration/mozilla-inbound", 04:17:38 INFO - "revision": "79b1ba1f1f4bcc68801315438fa632e6c916549e", 04:17:38 INFO - "stage_platform": "linux64-pgo", 04:17:38 INFO - "builduid": "5eea57702cd640139e1f7c0364126b00", 04:17:38 INFO - "slavebuilddir": "test" 04:17:38 INFO - } 04:17:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:17:38 INFO - Running post-action listener: _resource_record_post_action 04:17:38 INFO - [mozharness: 2016-07-21 11:17:38.355640Z] Finished read-buildbot-config step (success) 04:17:38 INFO - [mozharness: 2016-07-21 11:17:38.355729Z] Running download-and-extract step. 04:17:38 INFO - Running pre-action listener: _resource_record_pre_action 04:17:38 INFO - Running main action method: download_and_extract 04:17:38 INFO - mkdir: /builds/slave/test/build/tests 04:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:38 INFO - https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:17:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:17:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:17:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:17:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:17:39 INFO - Downloaded 1361 bytes. 04:17:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:17:39 INFO - Using the following test package requirements: 04:17:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:17:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:17:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:17:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:39 INFO - u'jsshell-linux-x86_64.zip'], 04:17:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:17:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:17:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:17:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:17:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:17:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:17:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:17: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')]} 04:17:39 INFO - https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:17:39 INFO - Downloaded 24347469 bytes. 04:17:39 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'] 04:17:39 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 04:17:41 INFO - Return code: 0 04:17:41 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 04:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:41 INFO - https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:17:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:17:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:17:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:17:42 INFO - Downloaded 24347469 bytes. 04:17:42 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'] 04:17:42 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 04:17:44 INFO - Return code: 0 04:17: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')]} 04:17:44 INFO - https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:17:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:17:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:17:44 INFO - Downloaded 14403317 bytes. 04:17:44 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'] 04:17:44 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 04:17:45 INFO - Return code: 0 04:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:45 INFO - https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:17:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:17:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:17:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:17:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:17:46 INFO - Downloaded 60923273 bytes. 04:17:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:17:46 INFO - mkdir: /builds/slave/test/properties 04:17:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:17:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:17:46 INFO - Contents: 04:17:46 INFO - build_url:https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:17:47 INFO - Running post-action listener: _resource_record_post_action 04:17:47 INFO - Running post-action listener: set_extra_try_arguments 04:17:47 INFO - [mozharness: 2016-07-21 11:17:47.051644Z] Finished download-and-extract step (success) 04:17:47 INFO - [mozharness: 2016-07-21 11:17:47.051877Z] Running populate-webroot step. 04:17:47 INFO - Running pre-action listener: _resource_record_pre_action 04:17:47 INFO - Running main action method: populate_webroot 04:17:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:17:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:17:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:17:47 INFO - '--tppagecycles', 04:17:47 INFO - '7'], 04:17:47 INFO - 'tests': ['tsvgm']}}, 04:17:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:17:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:17:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:17:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:17:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:47 INFO - 'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:17:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:17:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:47 INFO - 'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['damp', 'tps']}, 04:17:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:47 INFO - 'tests': ['damp', 'tps']}, 04:17:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['dromaeo_dom']}, 04:17:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:17:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['basic_compositor_video']}, 04:17:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:17:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['a11yr', 04:17:47 INFO - 'ts_paint', 04:17:47 INFO - 'tpaint', 04:17:47 INFO - 'sessionrestore', 04:17:47 INFO - 'sessionrestore_no_auto_restore', 04:17:47 INFO - 'tabpaint']}, 04:17:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:17:47 INFO - 'ts_paint', 04:17:47 INFO - 'tpaint', 04:17:47 INFO - 'sessionrestore', 04:17:47 INFO - 'sessionrestore_no_auto_restore', 04:17:47 INFO - 'tabpaint']}, 04:17:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:17:47 INFO - 'ts_paint', 04:17:47 INFO - 'tpaint', 04:17:47 INFO - 'sessionrestore', 04:17:47 INFO - 'sessionrestore_no_auto_restore', 04:17:47 INFO - 'tabpaint']}, 04:17:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:17:47 INFO - 'ts_paint', 04:17:47 INFO - 'tpaint', 04:17:47 INFO - 'sessionrestore', 04:17:47 INFO - 'sessionrestore_no_auto_restore', 04:17:47 INFO - 'tabpaint']}, 04:17:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['a11yr', 04:17:47 INFO - 'ts_paint', 04:17:47 INFO - 'tpaint', 04:17:47 INFO - 'sessionrestore', 04:17:47 INFO - 'sessionrestore_no_auto_restore', 04:17:47 INFO - 'tabpaint']}, 04:17:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['a11yr', 04:17:47 INFO - 'ts_paint', 04:17:47 INFO - 'tpaint', 04:17:47 INFO - 'sessionrestore', 04:17:47 INFO - 'sessionrestore_no_auto_restore', 04:17:47 INFO - 'tabpaint']}, 04:17:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['tsvgx', 04:17:47 INFO - 'tsvgr_opacity', 04:17:47 INFO - 'tart', 04:17:47 INFO - 'tscrollx', 04:17:47 INFO - 'cart']}, 04:17:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:17:47 INFO - 'tsvgr_opacity', 04:17:47 INFO - 'tart', 04:17:47 INFO - 'tscrollx', 04:17:47 INFO - 'cart']}, 04:17:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:47 INFO - 'talos_options': ['--disable-e10s'], 04:17:47 INFO - 'tests': ['tp5o']}, 04:17:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:47 INFO - 'tests': ['tp5o']}, 04:17:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:47 INFO - 'talos_options': ['--disable-e10s', 04:17:47 INFO - '--xperf_path', 04:17:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:17:47 INFO - 'tests': ['tp5n']}, 04:17:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:47 INFO - 'talos_options': ['--xperf_path', 04:17:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:17:47 INFO - 'tests': ['tp5n']}}, 04:17:47 INFO - 'talos.zip': {'path': '', 04:17:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:17:47 INFO - Running post-action listener: _resource_record_post_action 04:17:47 INFO - [mozharness: 2016-07-21 11:17:47.071279Z] Finished populate-webroot step (success) 04:17:47 INFO - [mozharness: 2016-07-21 11:17:47.071369Z] Running create-virtualenv step. 04:17:47 INFO - Running pre-action listener: _resource_record_pre_action 04:17:47 INFO - Running main action method: create_virtualenv 04:17:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:17:47 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 04:17:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:17:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:17:47 INFO - Using real prefix '/usr' 04:17:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:17:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:17:49 INFO - Installing pip.................done. 04:17:49 INFO - Return code: 0 04:17:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:49 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 0x1c5f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d570>, '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 0x1f1e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e900>, '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': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', '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 04:17:49 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 04:17:49 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 04:17:49 INFO - Using env: {'DISPLAY': ':0', 04:17:49 INFO - 'HOME': '/home/cltbld', 04:17:49 INFO - 'LANG': 'en_US.UTF-8', 04:17:49 INFO - 'LANGUAGE': 'en_US:en', 04:17:49 INFO - 'LOGNAME': 'cltbld', 04:17:49 INFO - 'MAIL': '/var/mail/cltbld', 04:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:49 INFO - 'MOZ_NO_REMOTE': '1', 04:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:49 INFO - 'NO_EM_RESTART': '1', 04:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:49 INFO - 'PWD': '/builds/slave/test', 04:17:49 INFO - 'SHELL': '/bin/bash', 04:17:49 INFO - 'SHLVL': '1', 04:17:49 INFO - 'TERM': 'linux', 04:17:49 INFO - 'TMOUT': '86400', 04:17:49 INFO - 'USER': 'cltbld', 04:17:49 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', 04:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:49 INFO - '_': '/tools/buildbot/bin/python'} 04:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:49 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 04:17:49 INFO - Cleaning up... 04:17:49 INFO - Return code: 0 04:17:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:49 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 0x1c5f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d570>, '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 0x1f1e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e900>, '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': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', '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 04:17:49 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 04:17:49 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 04:17:49 INFO - Using env: {'DISPLAY': ':0', 04:17:49 INFO - 'HOME': '/home/cltbld', 04:17:49 INFO - 'LANG': 'en_US.UTF-8', 04:17:49 INFO - 'LANGUAGE': 'en_US:en', 04:17:49 INFO - 'LOGNAME': 'cltbld', 04:17:49 INFO - 'MAIL': '/var/mail/cltbld', 04:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:49 INFO - 'MOZ_NO_REMOTE': '1', 04:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:49 INFO - 'NO_EM_RESTART': '1', 04:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:49 INFO - 'PWD': '/builds/slave/test', 04:17:49 INFO - 'SHELL': '/bin/bash', 04:17:49 INFO - 'SHLVL': '1', 04:17:49 INFO - 'TERM': 'linux', 04:17:49 INFO - 'TMOUT': '86400', 04:17:49 INFO - 'USER': 'cltbld', 04:17:49 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', 04:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:49 INFO - '_': '/tools/buildbot/bin/python'} 04:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:50 INFO - Downloading/unpacking psutil>=3.1.1 04:17:50 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 04:17:50 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 04:17:50 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 04:17:50 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 04:17:50 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 04:17:50 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 04:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:17:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:52 INFO - Installing collected packages: psutil 04:17:52 INFO - Running setup.py install for psutil 04:17:52 INFO - building 'psutil._psutil_linux' extension 04:17:52 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 04:17:52 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 04:17:52 INFO - building 'psutil._psutil_posix' extension 04:17:52 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 04:17:52 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 04:17:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:52 INFO - Successfully installed psutil 04:17:52 INFO - Cleaning up... 04:17:52 INFO - Return code: 0 04:17:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:52 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 0x1c5f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d570>, '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 0x1f1e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e900>, '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': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', '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 04:17:52 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 04:17:52 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 04:17:52 INFO - Using env: {'DISPLAY': ':0', 04:17:52 INFO - 'HOME': '/home/cltbld', 04:17:52 INFO - 'LANG': 'en_US.UTF-8', 04:17:52 INFO - 'LANGUAGE': 'en_US:en', 04:17:52 INFO - 'LOGNAME': 'cltbld', 04:17:52 INFO - 'MAIL': '/var/mail/cltbld', 04:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:52 INFO - 'MOZ_NO_REMOTE': '1', 04:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:52 INFO - 'NO_EM_RESTART': '1', 04:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:52 INFO - 'PWD': '/builds/slave/test', 04:17:52 INFO - 'SHELL': '/bin/bash', 04:17:52 INFO - 'SHLVL': '1', 04:17:52 INFO - 'TERM': 'linux', 04:17:52 INFO - 'TMOUT': '86400', 04:17:52 INFO - 'USER': 'cltbld', 04:17:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', 04:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:52 INFO - '_': '/tools/buildbot/bin/python'} 04:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:17:54 INFO - Installing collected packages: mozsystemmonitor 04:17:54 INFO - Running setup.py install for mozsystemmonitor 04:17:54 INFO - Successfully installed mozsystemmonitor 04:17:54 INFO - Cleaning up... 04:17:55 INFO - Return code: 0 04:17:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d570>, '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 0x1f1e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e900>, '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': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', '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 04:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:17:55 INFO - Using env: {'DISPLAY': ':0', 04:17:55 INFO - 'HOME': '/home/cltbld', 04:17:55 INFO - 'LANG': 'en_US.UTF-8', 04:17:55 INFO - 'LANGUAGE': 'en_US:en', 04:17:55 INFO - 'LOGNAME': 'cltbld', 04:17:55 INFO - 'MAIL': '/var/mail/cltbld', 04:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:55 INFO - 'MOZ_NO_REMOTE': '1', 04:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:55 INFO - 'NO_EM_RESTART': '1', 04:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:55 INFO - 'PWD': '/builds/slave/test', 04:17:55 INFO - 'SHELL': '/bin/bash', 04:17:55 INFO - 'SHLVL': '1', 04:17:55 INFO - 'TERM': 'linux', 04:17:55 INFO - 'TMOUT': '86400', 04:17:55 INFO - 'USER': 'cltbld', 04:17:55 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', 04:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:55 INFO - '_': '/tools/buildbot/bin/python'} 04:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:55 INFO - Downloading/unpacking jsonschema==2.5.1 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:17:57 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 04:17:57 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 04:17:57 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 04:17:57 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 04:17:57 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 04:17:57 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 04:17:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:57 INFO - warning: no files found matching '*.txt' 04:17:57 INFO - no previously-included directories found matching 'build' 04:17:57 INFO - no previously-included directories found matching 'dist' 04:17:57 INFO - no previously-included directories found matching '.git*' 04:17:57 INFO - Installing collected packages: jsonschema, functools32 04:17:57 INFO - Running setup.py install for functools32 04:17:57 INFO - warning: no files found matching '*.txt' 04:17:57 INFO - no previously-included directories found matching 'build' 04:17:57 INFO - no previously-included directories found matching 'dist' 04:17:57 INFO - no previously-included directories found matching '.git*' 04:17:57 INFO - Successfully installed jsonschema functools32 04:17:57 INFO - Cleaning up... 04:17:57 INFO - Return code: 0 04:17:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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', '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 0x1c5f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d570>, '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 0x1f1e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e900>, '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': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', '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 04:17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:17: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 blobuploader==1.2.4 04:17:57 INFO - Using env: {'DISPLAY': ':0', 04:17:57 INFO - 'HOME': '/home/cltbld', 04:17:57 INFO - 'LANG': 'en_US.UTF-8', 04:17:57 INFO - 'LANGUAGE': 'en_US:en', 04:17:57 INFO - 'LOGNAME': 'cltbld', 04:17:57 INFO - 'MAIL': '/var/mail/cltbld', 04:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:57 INFO - 'MOZ_NO_REMOTE': '1', 04:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:57 INFO - 'NO_EM_RESTART': '1', 04:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:57 INFO - 'PWD': '/builds/slave/test', 04:17:57 INFO - 'SHELL': '/bin/bash', 04:17:57 INFO - 'SHLVL': '1', 04:17:57 INFO - 'TERM': 'linux', 04:17:57 INFO - 'TMOUT': '86400', 04:17:57 INFO - 'USER': 'cltbld', 04:17:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', 04:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:57 INFO - '_': '/tools/buildbot/bin/python'} 04:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:57 INFO - Downloading/unpacking blobuploader==1.2.4 04:17:57 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 04:17:57 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 04:17:57 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 04:17:57 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 04:17:57 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 04:17:57 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 04:17:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:17:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:17:59 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 04:17:59 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 04:17:59 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 04:17:59 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 04:17:59 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 04:17:59 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 04:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:18:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:18:00 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 04:18:00 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 04:18:00 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 04:18:00 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 04:18:00 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 04:18:00 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 04:18:00 INFO - Downloading docopt-0.6.1.tar.gz 04:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:18:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:18:00 INFO - Running setup.py install for blobuploader 04:18:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:18:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:18:00 INFO - Running setup.py install for requests 04:18:00 INFO - Running setup.py install for docopt 04:18:01 INFO - Successfully installed blobuploader requests docopt 04:18:01 INFO - Cleaning up... 04:18:01 INFO - Return code: 0 04:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:01 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')]} 04:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:01 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')]} 04:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:01 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 0x1c5f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d570>, '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 0x1f1e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e900>, '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': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', '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 04:18:01 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 04:18:01 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 04:18:01 INFO - Using env: {'DISPLAY': ':0', 04:18:01 INFO - 'HOME': '/home/cltbld', 04:18:01 INFO - 'LANG': 'en_US.UTF-8', 04:18:01 INFO - 'LANGUAGE': 'en_US:en', 04:18:01 INFO - 'LOGNAME': 'cltbld', 04:18:01 INFO - 'MAIL': '/var/mail/cltbld', 04:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:01 INFO - 'MOZ_NO_REMOTE': '1', 04:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:01 INFO - 'NO_EM_RESTART': '1', 04:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:01 INFO - 'PWD': '/builds/slave/test', 04:18:01 INFO - 'SHELL': '/bin/bash', 04:18:01 INFO - 'SHLVL': '1', 04:18:01 INFO - 'TERM': 'linux', 04:18:01 INFO - 'TMOUT': '86400', 04:18:01 INFO - 'USER': 'cltbld', 04:18:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', 04:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:01 INFO - '_': '/tools/buildbot/bin/python'} 04:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:01 INFO - Running setup.py (path:/tmp/pip-p3Yfix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:01 INFO - Running setup.py (path:/tmp/pip-3TKkvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:01 INFO - Running setup.py (path:/tmp/pip-BMojGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:01 INFO - Running setup.py (path:/tmp/pip-HoS6yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:01 INFO - Running setup.py (path:/tmp/pip-8q6M0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:01 INFO - Running setup.py (path:/tmp/pip-vrgjKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:01 INFO - Running setup.py (path:/tmp/pip-ekbwVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:01 INFO - Running setup.py (path:/tmp/pip-h6xt8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:01 INFO - Running setup.py (path:/tmp/pip-6maO0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:01 INFO - Running setup.py (path:/tmp/pip-emomZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:02 INFO - Running setup.py (path:/tmp/pip-NBVPtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:02 INFO - Running setup.py (path:/tmp/pip-X8lxJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:02 INFO - Running setup.py (path:/tmp/pip-QsalHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:02 INFO - Running setup.py (path:/tmp/pip-lbY2YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:02 INFO - Running setup.py (path:/tmp/pip-brnd6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:02 INFO - Running setup.py (path:/tmp/pip-S0SSE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:02 INFO - Running setup.py (path:/tmp/pip-5WBirs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:18:02 INFO - Running setup.py install for manifestparser 04:18:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:18:02 INFO - Running setup.py install for mozcrash 04:18:02 INFO - Running setup.py install for mozdebug 04:18:02 INFO - Running setup.py install for mozdevice 04:18:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:18:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:18:02 INFO - Running setup.py install for mozfile 04:18:03 INFO - Running setup.py install for mozhttpd 04:18:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Running setup.py install for mozinfo 04:18:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Running setup.py install for mozInstall 04:18:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Running setup.py install for mozleak 04:18:03 INFO - Running setup.py install for mozlog 04:18:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Running setup.py install for moznetwork 04:18:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Running setup.py install for mozprocess 04:18:03 INFO - Running setup.py install for mozprofile 04:18:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:18:03 INFO - Running setup.py install for mozrunner 04:18:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:18:04 INFO - Running setup.py install for mozscreenshot 04:18:04 INFO - Running setup.py install for moztest 04:18:04 INFO - Running setup.py install for mozversion 04:18:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:18:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:18:04 INFO - Cleaning up... 04:18:04 INFO - Return code: 0 04:18:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:04 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')]} 04:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:04 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')]} 04:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:04 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 0x1c5f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d570>, '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 0x1f1e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e900>, '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': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', '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 04:18:04 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 04:18:04 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 04:18:04 INFO - Using env: {'DISPLAY': ':0', 04:18:04 INFO - 'HOME': '/home/cltbld', 04:18:04 INFO - 'LANG': 'en_US.UTF-8', 04:18:04 INFO - 'LANGUAGE': 'en_US:en', 04:18:04 INFO - 'LOGNAME': 'cltbld', 04:18:04 INFO - 'MAIL': '/var/mail/cltbld', 04:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:04 INFO - 'MOZ_NO_REMOTE': '1', 04:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:04 INFO - 'NO_EM_RESTART': '1', 04:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:04 INFO - 'PWD': '/builds/slave/test', 04:18:04 INFO - 'SHELL': '/bin/bash', 04:18:04 INFO - 'SHLVL': '1', 04:18:04 INFO - 'TERM': 'linux', 04:18:04 INFO - 'TMOUT': '86400', 04:18:04 INFO - 'USER': 'cltbld', 04:18:04 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', 04:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:04 INFO - '_': '/tools/buildbot/bin/python'} 04:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:04 INFO - Running setup.py (path:/tmp/pip-id89LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:04 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)) 04:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:04 INFO - Running setup.py (path:/tmp/pip-tQW67a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:04 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)) 04:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:04 INFO - Running setup.py (path:/tmp/pip-GyH15H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:04 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)) 04:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:04 INFO - Running setup.py (path:/tmp/pip-MGpN6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:04 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)) 04:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:04 INFO - Running setup.py (path:/tmp/pip-Wj0Sbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:04 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)) 04:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:04 INFO - Running setup.py (path:/tmp/pip-vXtVeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:04 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)) 04:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:04 INFO - Running setup.py (path:/tmp/pip-aUnh2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:05 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)) 04:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:05 INFO - Running setup.py (path:/tmp/pip-SVE5rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:05 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)) 04:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:05 INFO - Running setup.py (path:/tmp/pip-wtUnt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:05 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)) 04:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:05 INFO - Running setup.py (path:/tmp/pip-IGsL9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:05 INFO - Running setup.py (path:/tmp/pip-FqrIZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:05 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)) 04:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:05 INFO - Running setup.py (path:/tmp/pip-b2T2xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:05 INFO - Running setup.py (path:/tmp/pip-e_Izcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:05 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)) 04:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:05 INFO - Running setup.py (path:/tmp/pip-XjazZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:05 INFO - Running setup.py (path:/tmp/pip-mb_Ad4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:05 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)) 04:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:05 INFO - Running setup.py (path:/tmp/pip-HMyk6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:05 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)) 04:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:05 INFO - Running setup.py (path:/tmp/pip-SVWObB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:05 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)) 04:18:05 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)) 04:18:05 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)) 04:18:05 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)) 04:18:05 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)) 04:18:05 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)) 04:18:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:07 INFO - Downloading blessings-1.6.tar.gz 04:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:18:07 INFO - Installing collected packages: blessings 04:18:07 INFO - Running setup.py install for blessings 04:18:07 INFO - Successfully installed blessings 04:18:07 INFO - Cleaning up... 04:18:08 INFO - Return code: 0 04:18:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:08 INFO - Reading from file tmpfile_stdout 04:18:08 INFO - Current package versions: 04:18:08 INFO - argparse == 1.2.1 04:18:08 INFO - blessings == 1.6 04:18:08 INFO - blobuploader == 1.2.4 04:18:08 INFO - docopt == 0.6.1 04:18:08 INFO - functools32 == 3.2.3-2 04:18:08 INFO - jsonschema == 2.5.1 04:18:08 INFO - manifestparser == 1.1 04:18:08 INFO - mozInstall == 1.12 04:18:08 INFO - mozcrash == 0.17 04:18:08 INFO - mozdebug == 0.1 04:18:08 INFO - mozdevice == 0.48 04:18:08 INFO - mozfile == 1.2 04:18:08 INFO - mozhttpd == 0.7 04:18:08 INFO - mozinfo == 0.9 04:18:08 INFO - mozleak == 0.1 04:18:08 INFO - mozlog == 3.3 04:18:08 INFO - moznetwork == 0.27 04:18:08 INFO - mozprocess == 0.23 04:18:08 INFO - mozprofile == 0.28 04:18:08 INFO - mozrunner == 6.12 04:18:08 INFO - mozscreenshot == 0.1 04:18:08 INFO - mozsystemmonitor == 0.3 04:18:08 INFO - moztest == 0.7 04:18:08 INFO - mozversion == 1.4 04:18:08 INFO - psutil == 3.1.1 04:18:08 INFO - requests == 1.2.3 04:18:08 INFO - wsgiref == 0.1.2 04:18:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:08 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 0x1c5f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d570>, '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 0x1f1e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e900>, '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': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', '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 04:18:08 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 04:18:08 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 04:18:08 INFO - Using env: {'DISPLAY': ':0', 04:18:08 INFO - 'HOME': '/home/cltbld', 04:18:08 INFO - 'LANG': 'en_US.UTF-8', 04:18:08 INFO - 'LANGUAGE': 'en_US:en', 04:18:08 INFO - 'LOGNAME': 'cltbld', 04:18:08 INFO - 'MAIL': '/var/mail/cltbld', 04:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:08 INFO - 'MOZ_NO_REMOTE': '1', 04:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:08 INFO - 'NO_EM_RESTART': '1', 04:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:08 INFO - 'PWD': '/builds/slave/test', 04:18:08 INFO - 'SHELL': '/bin/bash', 04:18:08 INFO - 'SHLVL': '1', 04:18:08 INFO - 'TERM': 'linux', 04:18:08 INFO - 'TMOUT': '86400', 04:18:08 INFO - 'USER': 'cltbld', 04:18:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', 04:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:08 INFO - '_': '/tools/buildbot/bin/python'} 04:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:08 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)) 04:18:08 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)) 04:18:08 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)) 04:18:08 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)) 04:18:08 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)) 04:18:08 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)) 04:18:08 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)) 04:18:08 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)) 04:18:08 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)) 04:18:08 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)) 04:18:08 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)) 04:18:08 INFO - Cleaning up... 04:18:08 INFO - Return code: 0 04:18:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d570>, '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 0x1f1e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e900>, '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': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', '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 04:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:18:08 INFO - Using env: {'DISPLAY': ':0', 04:18:08 INFO - 'HOME': '/home/cltbld', 04:18:08 INFO - 'LANG': 'en_US.UTF-8', 04:18:08 INFO - 'LANGUAGE': 'en_US:en', 04:18:08 INFO - 'LOGNAME': 'cltbld', 04:18:08 INFO - 'MAIL': '/var/mail/cltbld', 04:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:08 INFO - 'MOZ_NO_REMOTE': '1', 04:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:08 INFO - 'NO_EM_RESTART': '1', 04:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:08 INFO - 'PWD': '/builds/slave/test', 04:18:08 INFO - 'SHELL': '/bin/bash', 04:18:08 INFO - 'SHLVL': '1', 04:18:08 INFO - 'TERM': 'linux', 04:18:08 INFO - 'TMOUT': '86400', 04:18:08 INFO - 'USER': 'cltbld', 04:18:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', 04:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:08 INFO - '_': '/tools/buildbot/bin/python'} 04:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:18:08 INFO - Cleaning up... 04:18:08 INFO - Return code: 0 04:18:08 INFO - Running post-action listener: _resource_record_post_action 04:18:08 INFO - Running post-action listener: _start_resource_monitoring 04:18:08 INFO - Starting resource monitoring. 04:18:08 INFO - [mozharness: 2016-07-21 11:18:08.742126Z] Finished create-virtualenv step (success) 04:18:08 INFO - [mozharness: 2016-07-21 11:18:08.742566Z] Running install step. 04:18:08 INFO - Running pre-action listener: _resource_record_pre_action 04:18:08 INFO - Running main action method: install 04:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:08 INFO - Reading from file tmpfile_stdout 04:18:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:18:09 INFO - Reading from file tmpfile_stdout 04:18:09 INFO - Output received: 04:18:09 INFO - Usage: mozinstall [options] installer 04:18:09 INFO - Options: 04:18:09 INFO - -h, --help show this help message and exit 04:18:09 INFO - -d DEST, --destination=DEST 04:18:09 INFO - Directory to install application into. [default: 04:18:09 INFO - "/builds/slave/test"] 04:18:09 INFO - --app=APP Application being installed. [default: firefox] 04:18:09 INFO - mkdir: /builds/slave/test/build/application 04:18:09 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'] 04:18:09 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 04:18:26 INFO - Reading from file tmpfile_stdout 04:18:26 INFO - Output received: 04:18:26 INFO - /builds/slave/test/build/application/firefox/firefox 04:18:26 INFO - Running post-action listener: _resource_record_post_action 04:18:26 INFO - [mozharness: 2016-07-21 11:18:26.273638Z] Finished install step (success) 04:18:26 INFO - [mozharness: 2016-07-21 11:18:26.273970Z] Running run-tests step. 04:18:26 INFO - Running pre-action listener: _resource_record_pre_action 04:18:26 INFO - Running main action method: run_tests 04:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:18:26 INFO - Python 2.7.3 04:18:26 INFO - Return code: 0 04:18:26 INFO - grabbing minidump binary from tooltool 04:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:26 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 0x1f1d570>, '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 0x1f1e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:18:26 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 04:18:26 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 04:18:26 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 04:18:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:18:26 INFO - Return code: 0 04:18:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:18:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:18:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:18:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:18:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:18:26 INFO - Using env: {'DISPLAY': ':0', 04:18:26 INFO - 'HOME': '/home/cltbld', 04:18:26 INFO - 'LANG': 'en_US.UTF-8', 04:18:26 INFO - 'LANGUAGE': 'en_US:en', 04:18:26 INFO - 'LOGNAME': 'cltbld', 04:18:26 INFO - 'MAIL': '/var/mail/cltbld', 04:18:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:18:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:26 INFO - 'MOZ_NO_REMOTE': '1', 04:18:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:26 INFO - 'NO_EM_RESTART': '1', 04:18:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:26 INFO - 'PWD': '/builds/slave/test', 04:18:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:18:26 INFO - 'SHELL': '/bin/bash', 04:18:26 INFO - 'SHLVL': '1', 04:18:26 INFO - 'TERM': 'linux', 04:18:26 INFO - 'TMOUT': '86400', 04:18:26 INFO - 'USER': 'cltbld', 04:18:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260', 04:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:26 INFO - '_': '/tools/buildbot/bin/python'} 04:18:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:18:26 INFO - mozversion application_buildid: 20160721013053 04:18:26 INFO - mozversion application_changeset: 79b1ba1f1f4bcc68801315438fa632e6c916549e 04:18:26 INFO - mozversion application_display_name: Nightly 04:18:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:18:26 INFO - mozversion application_name: Firefox 04:18:26 INFO - mozversion application_remotingname: firefox 04:18:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:18:26 INFO - mozversion application_vendor: Mozilla 04:18:26 INFO - mozversion application_version: 50.0a1 04:18:26 INFO - mozversion platform_buildid: 20160721013053 04:18:26 INFO - mozversion platform_changeset: 79b1ba1f1f4bcc68801315438fa632e6c916549e 04:18:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:18:26 INFO - mozversion platform_version: 50.0a1 04:18:26 INFO - using testdate: 1469099906 04:18:26 INFO - actual date: 1469099906 04:18:26 INFO - starting webserver on 'localhost:38223' 04:18:26 INFO - SUITE-START | Running 2 tests 04:18:26 INFO - TEST-START | dromaeo_css 04:18:26 INFO - operating with platform_type : linux_ 04:18:26 INFO - Initialising browser for dromaeo_css test... 04:18:26 INFO - TEST-INFO | started process 18116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQeQkOJ/profile http://localhost:38223/getInfo.html) 04:18:31 INFO - PROCESS | 18116 | __metrics Screen width/height:1600/1200 04:18:31 INFO - PROCESS | 18116 | colorDepth:24 04:18:31 INFO - PROCESS | 18116 | Browser inner width/height: 1024/697 04:18:31 INFO - PROCESS | 18116 | __metrics 04:18:31 ERROR - PROCESS | 18116 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:18:32 INFO - TEST-INFO | 18116: exit 0 04:18:32 INFO - Browser initialized. 04:18:32 INFO - Running cycle 1/1 for dromaeo_css test... 04:18:32 INFO - TEST-INFO | started process 18240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQeQkOJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:44 INFO - PROCESS | 18240 | RSS: Main: 167251968 04:18:44 INFO - PROCESS | 18240 | 04:19:34 INFO - PROCESS | 18240 | 1469099974241 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] 04:21:42 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:38223/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38223/tests/dromaeo/cssquery-ext.html) 04:21:43 INFO - PROCESS | 18240 | RSS: Main: 172769280 04:21:43 INFO - PROCESS | 18240 | 04:24:46 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:38223/tests/dromaeo/cssquery-ext.html (next: http://localhost:38223/tests/dromaeo/cssquery-jquery.html) 04:24:46 INFO - PROCESS | 18240 | RSS: Main: 169885696 04:24:46 INFO - PROCESS | 18240 | 04:27:48 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:38223/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38223/tests/dromaeo/cssquery-mootools.html) 04:27:49 INFO - PROCESS | 18240 | RSS: Main: 173056000 04:27:49 INFO - PROCESS | 18240 | 04:30:51 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:38223/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38223/tests/dromaeo/cssquery-prototype.html) 04:30:51 INFO - PROCESS | 18240 | RSS: Main: 167964672 04:30:51 INFO - PROCESS | 18240 | 04:33:54 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:38223/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38223/tests/dromaeo/cssquery-yui.html) 04:33:55 INFO - PROCESS | 18240 | RSS: Main: 170110976 04:33:55 INFO - PROCESS | 18240 | 04:36:58 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:38223/tests/dromaeo/cssquery-yui.html (next: http://localhost:38223/tests/dromaeo/cssquery-dojo.html) 04:36:58 INFO - PROCESS | 18240 | RSS: Main: 171134976 04:36:58 INFO - PROCESS | 18240 | 04:36:58 INFO - PROCESS | 18240 | __start_tp_report 04:36:58 INFO - PROCESS | 18240 | _x_x_mozilla_page_load 04:36:58 INFO - PROCESS | 18240 | _x_x_mozilla_page_load_details 04:36:58 INFO - PROCESS | 18240 | |i|pagename|runs| 04:36:58 INFO - PROCESS | 18240 | |0;dojo.html;3042.5436184572313;3069.5088785794264;3084.151858238984;3105.7981231219983;3106.409782141393;5388.892222155555;5402.486763757442;5461.180822876566;5493.395726470085;5514.290569923327;5266.605004624659;5404.243405923174;5413.188021796733;5441.211024401459;5496.258005169301;4854.34466347044;4885.291632713254;4914.017196560684;5040.470750571192;5044.419891712445;4932.630052746058;5063.265826455162;5069.949300506984;5111.7699703513435;5112.795488180468;4885.340479035356;4922.163232250526;4925.458199598042;4966.950330496685;4971.502849715036;4957.5786058185095;5003.74981250936;5004.174311238678;5008.5993120550265;5026.924596131061;4878.682885612424;4933.70397776131;4936.555709986119;4949.678270912379;5004.84985450437;5329.094054010828;5329.467053294678;5406.8918621627745;5411.810586629449;5490.121580547093;5785.016547186989;5798.304203495608;5799.739011744439;5800.53595712342;5844.912326315109;5771.769129234825;5796.188533605298;5830.533557315404;5842.4741773240185;5849.707514624294;5313.893722125575;5377.892442151135;5396.649217800869;5409.594280428944;5421.078416669176;5938.198343223696;5973.820785376446;5978.880422391615;5994.6403215807195;6025.186599809057;5709.800156994485;5710.457506536873;5725.227094342294;5728.51307638847;5729.0260655688635;5531.668099914018;5569.220309156722;5739.426057394227;5784.537237021028;5813.912791308134;5538.556915446755;5559.332880054339;5575.4424557544735;5691.203231547586;5857.88284234313;5673.035583950738;5700.287464066992;5705.657660540381;5720.48515633595;5723.828285151452;4410.33844923264;4412.205802955435;4429.291313389842;4437.179121862466;4451.844185453494;3870.2259548090497;3928.1161738609158;3934.075492259317;3946.782926939046;3989.501312335958;5405.162199859028;5436.972815135899;5460.808871689551;5476.58925580583;5480;5786.739596718157;5801.216835727208;5803.7968671096305;5811.476967072984;5820.738066787005;5466.9179962300595;5567.498925096761;5590.133529302964;5641;5659.320881494247;5022.121128802518;5048.545630893237;5061.291419201315;5067.695938243717;5083.694978301313;6099.878002439927;6109.266887973472;6116.541259405562;6119.2350956130485;6121.449069583669;5692.829215123553;5700.743466544015;5724.313082429969;5737.770489180386;5833.0375488044;5979.641221526722;5979.790707325223;5992.041273396236;6000.51995840323;6007.219061522149;5609.943900560942;5626.774929002794;5644.717764111696;5662.886742265049;5678.602497825113;5653.038983372754;5734.799282025109;5815.331236907809;5819.5635327351465;5896.262967129109;5691.288588926384;5694.316681998187;5698.344690360662;5699.658020518782;5720.2849643794525;5654.010548154139;5663.405342438985;5675.545956323567;5680.488756011813;5697.857553561194;5491.341039075336;5614.887702246014;5660.264165658438;5681.0910254359105;5767.567432442667;5704.543636509153;5723.399043100581;5733.627314224562;5775.393583673822;5785.0454674978155;5610.8316750495915;5614.550835933197;5626.662400255997;5643.35101463337;5650.85872853182 04:36:58 INFO - PROCESS | 18240 | |1;ext.html;551.471479038753;590.7194082810665;597.8355952113168;608.2943785209156;627.9811605651832;39252.60747392525;44173.7791311043;44174.33738493925;44213.115737685264;44277.33583996238;44273.114537709225;44591.554084459145;44668;44683.77658111705;44932.775336123355;8870.512121833313;9053.637854485813;9059.682911098113;9066.592003359865;9068.183863452288;8958.32812539059;9005;9041;9045.683401080963;9046.502442365667;8971.237444817198;9025.052369501207;9072.138146876036;9099.04460031697;9107.271418286522;8946.194842464209;8960.462372257685;8962.641494340218;8996.370254082216;9010.23413009895;8885.555722213929;8897.154770296811;8932.508712020835;8973;8994.370394072417;42163.7891810539;42551.57448425507;42671.57328426738;42697.14605707869;42744;3522.454019626962;3786.7159963002887;4008.959910400888;4238.894027649302;4437.334399840018;33015.6698433015;33442.665573344195;33479.83260083684;33694.49458258128;33827.15432114192;4482.238019536687;4505.684602077856;4572.474165470981;4685.250359942427;4702.247640377557;379299;379621;382365;383365;383673;30829.69170308268;31499.212519686735;31591.21021974469;57678.42321576815;57778.7111064442;35868.28263434717;35962.640373596456;36184.63815361865;36288.274234515164;36383.81808090943;14467.49363772284;14580.635484112981;14613.634659133606;14621.26893655313;14729.852701473063;12064.577739779066;12183.086268529896;12192.57325993586;12198.939005304917;12269.69325766863;8068.798280042928;8072.475289106189;8245.95877020611;8246.257836794597;8318.916810831935;3232.466643003878;3253.1053960161144;3285.852136653856;3288.8191149487006;3293.061477478907;947.8104379124203;1028.9382637041801;1055.5935964653663;1096.8135416979133;1135.03522006294;32601;33023.66976330254;33619.66380336214;33626;33956.83021584926;1089.716673664837;1116.7264020315074;1128.514738662383;1164.5225457562358;1168.485866218878;17309.91345043292;17551.848243224566;17562.736558951627;17564.91217543904;17606.735898961524;582984;583968;584290;588110;590077;59141.408585914454;59709.70145149247;59719.402805972255;59757.701211493666;59771.70114149401;1289.220021886745;1332.373784321387;1344.1196016608942;1349.743548725739;1352.1684164238923;29476.263093422836;30960.22599434942;32062.519062213618;32164.678353217103;32617.673823261463;50728.492715072374;51036.489635104655;51086.489135108175;51094.48905510897;51133;477307;478660;478920;479913;482787;27940.860295698392;28277.858610706815;28383.14850554487;28431.147065588066;28505.857470712515;46900.7654961723;47126.76436617795;47461.52538474571;48086.519134809605;48491.27263090986;40472.39291410572;41743.16513669649;42418.5758142427;42472.36291455692;42816.785916071465;40710.79644601758;41167;41306.586934130275;41549.16901661889;42956.78521607372;41785.58214417939;42209.36685949652;42323;42477;44901;33691.83154084214;39559;40001.1999760009;40754.1849163021;40908.795456022526;28906.27734306659;28974.710252897203;29075.563866541597;29473.557896631995;29485.115446536638 04:36:58 INFO - PROCESS | 18240 | |2;jquery.html;378.68947463080286;386.80852977776;387.1237580184713;394.9842006319747;409.93441049432096;18614.162362693678;19515.316963906265;19927.302544410948;20154.39536813896;20274;18912.43262702121;19160.61678766424;19295.517612059706;19875.403737887886;20082.698759518582;5827.155062515943;5890.440408161239;5916.763329466838;5931.228940237785;5935.762569497237;5659.8585035374235;5832.562557808182;5835.0663893777;5846.619969701956;5871.236739223895;5652.773889044433;5743.856403589902;5772.711364431782;5831.037878750022;5850.414958504158;5796.333421656522;5826.9708651456685;5829.621074630136;5835.79574714883;5839.182514447981;5081.974590127025;5169.612279079084;5200.765965531522;5208.687478751287;5219.060569097561;23606.763932360627;23743;23877.641835372484;23886.163984260642;24248.636270455958;2286.2455389721354;2300.344401845483;2323.3959170615594;2353.5881220786464;2427.5509030829353;14405.927970360186;14752.778708319276;14949.775753363709;14965.850341496554;15231.086134831945;1910.2836436336374;1947.6494231038407;1975.802419758027;2021.6765317549268;2048.8463365247517;80754.19245807525;81079;81936;81939.5903020487;85039.5748021256;8935.693793296521;9648.517574121266;9657.420554766737;10274.280800344053;10579.947100264604;12080.57717979884;12923.612291631267;12946.611601651966;12988.350582470839;13021.153625014344;6890;6962.512624116263;7068.92931070693;7083.858322833515;7198.676059577331;6853.246142924274;6862.4853136015;7034.437245020386;7057.964710176519;7111.964440177766;3768.1898391845884;3790.033541446913;3829.5404551454003;3853.9807300963316;3929.980350098231;1784.9107544622716;1848.6395152945315;1859.841913437373;1862.720591911197;1878.7181922711702;848.9151084891462;931.5575101826578;977.2768151567931;1049.5906596427399;1050.6165249683963;20136;20486.692699609517;20672;20761.169553217704;20835.479113022295;952.9809403812023;968.6270785747538;975.9024097590184;980.8332583460829;1008.2841182760176;10747.247692661438;11144.322373616687;11189.69587695607;11215.327080375204;11379.601713939972;516991;522096;522788;528265;528773;73930.63034684792;73981.57503123049;93844;95702;103405;975.1321324021626;986.2455221755363;996.9302148849656;1001.2590682894605;1006.6979906028163;17355.826441735928;17734.556636084202;18500.0749962504;18618.255269789057;18666.533336666147;39669.20661586694;41250.58749412587;41320.79339603283;43461.565384345755;43918.56081439145;59316.62733490785;59854;60508;61505.69247153735;61926.38073619206;8014.83970320602;8494.617742201739;8509.361797865062;8545.529995850287;8798.912010880065;12903;13340.266285354399;13430.462781489023;13720.176789392668;13839.654008649864;11673.416329183337;11859.822102668295;11919;11976.940115299367;11988.940055299669;11687.824682629598;11831.822522661994;11898.345590992578;11906.226095303777;12033.819492707791;11882;11936.820947685617;11985.580504682293;12147.514099435924;12434.191777534432;8448.450850694686;8481.236688698047;8586.570671466277;8686.087960764282;8827.470351778913;10579.206559507913;11535.423228838692;11794.587189448672;11828.23116497425;12272.447739851907 04:36:58 INFO - PROCESS | 18240 | |3;mootools.html;1501.8122734658168;1510.1392206442329;1681.403101898826;1773.1400270868635;1794.2284817528466;7754.806129846756;8295.087540370554;8515.063343032269;9124.178823905848;9131.817363652732;8180.263776260135;8489.617967191476;8535.231829135377;8540.274076703472;8572.742817715478;2300.0684722687297;2312.537492501498;2318.9652155217686;2327.627579587266;2329.5923213437663;2286.2912497125944;2303.9539209215804;2319.373769082347;2331.428799944016;2337.637666161748;2302.1482051640915;2322.2336628912503;2326.581215381231;2328.639060945556;2343.3087239264373;2266.9546609067725;2284.451731584416;2299.9195028174017;2307.457747429353;2316.745158032615;2190.113004233272;2204.9889750551147;2209.9116035358566;2213.7786221377896;2214.2803588833694;8498.447600905922;8522.74431767048;8568.785780355542;8595.699150529701;8604.913950860473;5103.642745007851;5189.143791274435;5206.739663016872;5228.451012643655;5230.372355317349;3108.782385233035;3130.733887619555;3310.1724568857785;3311.3542859142476;3322;1073.2701762801291;1082.7455547946226;1091.6779550032759;1096.7203363142428;1113.0761467981556;12229.816552751716;12237.938810305892;12285.201461904948;12290.569830055905;12348.99999999991;4468.865934021985;4654.2785868190485;4708.987567672898;4745.406824146981;4753.667243292936;10250.436226007492;10264.230182736324;10316.484175791331;10341.689749307532;10347.223958203165;5275.762590683428;5295.761690723926;5298.3906850712665;5307.203919412042;5308.681479111266;4308.763018034038;4782.115308667908;4880.145974454456;4892.633052521075;4900.142475066849;3729.179580492287;3895.415687646819;3937.1338305572726;3973.443717879499;3982.3230050891416;1217.697064141378;1250.337321219755;1252.3300034481508;1263.8420197475316;1271.3960868587533;967.1489089601106;987.4865070163619;1027.6968294353185;1040.2770074797943;1060.5280650110626;6152.020423630811;6156.8768624627255;6193.102000209944;6294.653794041372;6407.103005579223;455.9886002849889;456.7533531892807;463.0622988448419;463.3536216977298;464.13438936383403;4224.493060832659;4327.588879056485;4344.630706389992;4347.695661303678;4376.365427013129;10566.947165264124;10732.356058636507;10874.347539147677;10898.400587967737;10901.29141605809;10267.229957753198;10760.085392741705;10847.132229421628;10894.074003709615;10917.126629869592;8135.30849877767;8287.295579875778;8347.332213422911;8347.791305217419;8358.874616880752;6126.6017708848785;6204.255489341308;6279.183706118175;6365.267994180728;6511.186101737283;10127.64553240633;10190.745231369276;10222.48887555634;10225.795484090426;10234.6417875374;9915.950420247853;10439.686809395731;10582.523786429476;10638.14894808429;10638.946805266234;7050.823729406806;7448.9627551861895;7639.04511936008;7771.72798952034;7945.523268603903;8330.458520196167;8457.957710211409;8494.70268540598;8503.064662887202;8542.18849209324;7258.782236532912;7373.926260737324;7434.293742094493;7442.7395041173295;7533.58565278893;7419.4806363554035;7423.925760742323;7501.6249187539315;7574.810629734301;7683.961580192064;6754.5947243165565;6761.290064543152;6789.253182150058;6844.4182244509775;6861;5098.362704661918;5209.244659524272;5219.739013049257;5336.866578335573;5368.651037682538;5173.919770802218;5232.136697445031;5321.574274058144;5338.599605029716;5348.251244825806 04:36:58 INFO - PROCESS | 18240 | |4;prototype.html;333.644668428124;337.15038103977975;340.9505621684856;346.4387691939059;348.491202843848;5559.249501317321;5665.206871038058;5666.37669856316;5703.486686198241;5731;5491.341039075317;5497.890042199164;5521.475459831319;5558;5561.77752889885;4155.979220103895;4309.37514060461;4313.482382114151;4342.804573794171;4357.281048626973;4318.244307246235;4336.457942757155;4337.7397356158735;4368.929612245004;4397;4328.350747387885;4365.869023929287;4370;4372.797480692803;4378.737275763448;4303.924018995252;4327.437433133704;4333.285007973696;4362.629176519999;4363.869083927487;3865.845366185349;3869.916423401452;3886.6113388661192;3887.4168874668744;3889.533256009297;5436.510714035716;5444.91832622511;5476.014317422862;5476.890462190734;5493.945060549383;4832.921843607248;4951.356323677935;4970.061675946384;5003.824866129668;5020.799168033274;5695.629784064023;5739.713014349266;5751.130882463216;5777.220075289866;5828.6502809831545;4207.600277973587;4228.112096459748;4228.217779710732;4234.110836724291;4234.364845273203;5707.5148612368;5978.40215978403;6033.7586496540525;6038.245219347582;6101.511879049665;4173.561776013536;4195.328747400462;4224.640905523003;4225.112726327444;4233.830646774095;4276.5723427656985;4294.162638285505;4299.78501074945;4299.9785001075425;4302.483701955723;4767.809287628525;4883.804647814119;4887.608991280689;4899.706017638953;4953.2570114483115;5817.621854579439;5827.970860145672;5853;5856.970715146482;5904.881902361929;1462.7367073926796;1479.8446163152714;1482.5033613739517;1495.110409306461;1505.6762795998693;964.8697425847561;973.3381300715581;1002.6941782756329;1004.4080132989147;1007.4459047523833;5528.806491772769;5555.111182210827;5560.221568980346;5590.468905453975;5590.5248053915875;5879.441453061952;5889.411058894162;5902.527797776168;5944.910826337608;5967.045272756338;5448.754806033738;5589;5604.935062338142;5612.494875461147;5656.745446454837;3172.3179516404084;3182.8249446280215;3187.5974571188603;3217.9380804334983;3229.7416206703406;5918.844401822057;6067.848303792441;6138.570300079041;6191.628502289877;6238.691684076921;5946;5991.9700401498585;5992.910106348409;6023.343580515393;6066.636001839904;6121.540884433685;6162.198914141133;6173;6191.783287584913;6210.534209934273;5767.711614419179;5826.213461182686;5833.533317334688;5847.912281315868;5932.1694962706115;5850.765969361178;5875.529957603467;5878.353381128158;5881;5886.499647529837;5942.7920022799;6016.699165041643;6100.694965251809;6152.138700581832;6162.876742465215;4205.894852628709;4213.325867861127;4215.346621273708;4225.598568136023;4234.343676730112;5911.201987731602;5935.495482884004;5947.51312171957;5955.409396912357;5980.0431930890845;5524.4199359068325;5727.11229759388;5761.193432919478;5773.3072031356505;5842.678652674143;5746.511546518593;5817.76728930838;5821.505172060422;5824.912626310694;5840.240768700041;5639.802606908738;5681.971590142023;5744.913826292525;5787.710614469175;5805.883882322414;5900.734466948912;5903.380145084704;5917.201177841109;5935.910961335497;5941.58408911372;5793.217915581343;5807.332156802022;5813.912791308218;5895.587308888336;5895.616784908967 04:36:58 INFO - PROCESS | 18240 | |5;yui.html;744.3412579866816;755.2598453515556;767.4781148818801;851.6423102297034;853.9316854651629;13113.950883929287;13687.110337828059;13827.723445531083;13840.377183026776;13905.513307034256;12555.623331300052;12703.047271454654;12709.618711438648;12725;12759.170653907513;652.7552167937024;774.4578794843632;793.0443815202667;806.3025482957229;806.822499050208;796.2316364708056;804.2440106300088;806.2985202873508;806.3549160671469;807.5598798654747;858.2618947704968;858.8840506531601;864.0107077396377;865.0095640491634;865.3293697384514;851.3487182305541;854.5727136431784;855.1875718067829;856.1139220906363;856.8414843254018;622.9345918678519;627.1971875998729;628.8239292997922;629.2731894661673;629.3863483103983;13239.86760132396;13322.134061285986;13377.464901403931;13395.86604133956;13412;15070.924645376812;15301.12429046005;15403.845961540354;15438.382464701399;15520.379184832593;12177.51289948401;12252.693682657915;12408.193467424588;12427.502899883993;12546.121771476;3922.195949830278;3944.8027598619956;4059.533153687334;4117.505899292074;4123.814428350732;72529.63735181344;73339;74541;75712;75802.24197758007;11547.249428787101;11565.248258863146;11611.76776464466;11651.475683594259;11783.764324713458;21844.235451759112;21880.01539930707;21966.560668786537;21987.670184947237;22121.225757098746;8668.8699669505;8706.347023973227;9246.815063698688;9247.537623118817;9264;4862.270659401118;4960.082384758831;5022.673526220857;5061.8734531637;5136.8278620428855;3434.7252219822353;3539.2567560812518;3545.556805399325;3557.537520122419;3568.357695614762;609.2080295615682;634.1724050114644;639.2584601861818;657.1227411405731;660.831487970574;639.4309064932214;674.6828990374516;726.822547473097;775.1163673412315;813.9755807325789;9411.341206115507;10128.696139115838;10131.746706332253;10157.746056348502;10400.687979360631;603.2657847921353;640.8077576726963;737.2516895351223;778.7858338956719;823.6911158315631;4593.586577208067;5146.2280657900865;5184.948150518522;5186.533212010937;5224;90387;94080;94518.52740736252;108136;115321.42339288417;99092;105285;107478.46260768647;110365;110698.44650776856;92756.6519013292;93651.53174234221;94965;97433.5128324368;99596;9097.90902090997;9305.767355815888;9348.579313930753;9488.573014214515;9529.904700953179;53578.732106339216;55735.88528229494;55833.16250256168;56349.43650563442;57080;61781;62049.689751550955;64947.35052649413;82030.58984705278;82743.58628206821;12743.470783506038;13184.670383240496;13341.599752007456;13374.732505349644;14109.929450352682;13679.38442770058;13966.301684915918;14042.929785351416;14780;15157.621059473602;13322.933385333012;13690.315484225948;13720.176789392668;14134.434622614981;14375;14096.154230746188;14574.417023318949;14664.193469359288;14696.999003139248;15302.846971530142;10737;13806.516771912935;13847.238401887993;14473.493427729978;14938.402463901322;11659.317384813323;11745.077750988716;12150.635480935585;12177;12519.812202816784;10123.949380253347;10139.64511242103;10450.425226612306;11314.377709225742;11458.19792614509 04:36:58 INFO - PROCESS | 18240 | __end_tp_report 04:36:58 INFO - PROCESS | 18240 | __start_cc_report 04:36:58 INFO - PROCESS | 18240 | _x_x_mozilla_cycle_collect,375 04:36:58 INFO - PROCESS | 18240 | __end_cc_report 04:36:58 INFO - PROCESS | 18240 | __startTimestamp1469101018419__endTimestamp 04:36:58 INFO - PROCESS | 18240 | 04:36:58 INFO - PROCESS | 18240 | ------- Summary: start ------- 04:36:58 INFO - PROCESS | 18240 | Number of tests: 6 04:36:58 INFO - PROCESS | 18240 | 04:36:58 INFO - PROCESS | 18240 | [#0] dojo.html Cycles:165 Average:5390.39 Median:5614.89 stddev:614.23 (10.9%) stddev-sans-first:587.85 04:36:58 INFO - PROCESS | 18240 | Values: 3042.5 3069.5 3084.2 3105.8 3106.4 5388.9 5402.5 5461.2 5493.4 5514.3 5266.6 5404.2 5413.2 5441.2 5496.3 4854.3 4885.3 4914.0 5040.5 5044.4 4932.6 5063.3 5069.9 5111.8 5112.8 4885.3 4922.2 4925.5 4967.0 4971.5 4957.6 5003.7 5004.2 5008.6 5026.9 4878.7 4933.7 4936.6 4949.7 5004.8 5329.1 5329.5 5406.9 5411.8 5490.1 5785.0 5798.3 5799.7 5800.5 5844.9 5771.8 5796.2 5830.5 5842.5 5849.7 5313.9 5377.9 5396.6 5409.6 5421.1 5938.2 5973.8 5978.9 5994.6 6025.2 5709.8 5710.5 5725.2 5728.5 5729.0 5531.7 5569.2 5739.4 5784.5 5813.9 5538.6 5559.3 5575.4 5691.2 5857.9 5673.0 5700.3 5705.7 5720.5 5723.8 4410.3 4412.2 4429.3 4437.2 4451.8 3870.2 3928.1 3934.1 3946.8 3989.5 5405.2 5437.0 5460.8 5476.6 5480.0 5786.7 5801.2 5803.8 5811.5 5820.7 5466.9 5567.5 5590.1 5641.0 5659.3 5022.1 5048.5 5061.3 5067.7 5083.7 6099.9 6109.3 6116.5 6119.2 6121.4 5692.8 5700.7 5724.3 5737.8 5833.0 5979.6 5979.8 5992.0 6000.5 6007.2 5609.9 5626.8 5644.7 5662.9 5678.6 5653.0 5734.8 5815.3 5819.6 5896.3 5691.3 5694.3 5698.3 5699.7 5720.3 5654.0 5663.4 5675.5 5680.5 5697.9 5491.3 5614.9 5660.3 5681.1 5767.6 5704.5 5723.4 5733.6 5775.4 5785.0 5610.8 5614.6 5626.7 5643.4 5650.9 04:36:58 INFO - PROCESS | 18240 | 04:36:58 INFO - PROCESS | 18240 | [#1] ext.html Cycles:180 Average:62451.97 Median:23280.95 stddev:130396.48 (560.1%) stddev-sans-first:130679.45 04:36:58 INFO - PROCESS | 18240 | Values: 551.5 590.7 597.8 608.3 628.0 39252.6 44173.8 44174.3 44213.1 44277.3 44273.1 44591.6 44668.0 44683.8 44932.8 8870.5 9053.6 9059.7 9066.6 9068.2 8958.3 9005.0 9041.0 9045.7 9046.5 8971.2 9025.1 9072.1 9099.0 9107.3 8946.2 8960.5 8962.6 8996.4 9010.2 8885.6 8897.2 8932.5 8973.0 8994.4 42163.8 42551.6 42671.6 42697.1 42744.0 3522.5 3786.7 4009.0 4238.9 4437.3 33015.7 33442.7 33479.8 33694.5 33827.2 4482.2 4505.7 4572.5 4685.3 4702.2 379299.0 379621.0 382365.0 383365.0 383673.0 30829.7 31499.2 31591.2 57678.4 57778.7 35868.3 35962.6 36184.6 36288.3 36383.8 14467.5 14580.6 14613.6 14621.3 14729.9 12064.6 12183.1 12192.6 12198.9 12269.7 8068.8 8072.5 8246.0 8246.3 8318.9 3232.5 3253.1 3285.9 3288.8 3293.1 947.8 1028.9 1055.6 1096.8 1135.0 32601.0 33023.7 33619.7 33626.0 33956.8 1089.7 1116.7 1128.5 1164.5 1168.5 17309.9 17551.8 17562.7 17564.9 17606.7 582984.0 583968.0 584290.0 588110.0 590077.0 59141.4 59709.7 59719.4 59757.7 59771.7 1289.2 1332.4 1344.1 1349.7 1352.2 29476.3 30960.2 32062.5 32164.7 32617.7 50728.5 51036.5 51086.5 51094.5 51133.0 477307.0 478660.0 478920.0 479913.0 482787.0 27940.9 28277.9 28383.1 28431.1 28505.9 46900.8 47126.8 47461.5 48086.5 48491.3 40472.4 41743.2 42418.6 42472.4 42816.8 40710.8 41167.0 41306.6 41549.2 42956.8 41785.6 42209.4 42323.0 42477.0 44901.0 33691.8 39559.0 40001.2 40754.2 40908.8 28906.3 28974.7 29075.6 29473.6 29485.1 04:36:58 INFO - PROCESS | 18240 | 04:36:58 INFO - PROCESS | 18240 | [#2] jquery.html Cycles:180 Average:30023.52 Median:3809.79 stddev:86182.40 (2262.1%) stddev-sans-first:86395.42 04:36:58 INFO - PROCESS | 18240 | Values: 378.7 386.8 387.1 395.0 409.9 18614.2 19515.3 19927.3 20154.4 20274.0 18912.4 19160.6 19295.5 19875.4 20082.7 5827.2 5890.4 5916.8 5931.2 5935.8 5659.9 5832.6 5835.1 5846.6 5871.2 5652.8 5743.9 5772.7 5831.0 5850.4 5796.3 5827.0 5829.6 5835.8 5839.2 5082.0 5169.6 5200.8 5208.7 5219.1 23606.8 23743.0 23877.6 23886.2 24248.6 2286.2 2300.3 2323.4 2353.6 2427.6 14405.9 14752.8 14949.8 14965.9 15231.1 1910.3 1947.6 1975.8 2021.7 2048.8 80754.2 81079.0 81936.0 81939.6 85039.6 8935.7 9648.5 9657.4 10274.3 10579.9 12080.6 12923.6 12946.6 12988.4 13021.2 6890.0 6962.5 7068.9 7083.9 7198.7 6853.2 6862.5 7034.4 7058.0 7112.0 3768.2 3790.0 3829.5 3854.0 3930.0 1784.9 1848.6 1859.8 1862.7 1878.7 848.9 931.6 977.3 1049.6 1050.6 20136.0 20486.7 20672.0 20761.2 20835.5 953.0 968.6 975.9 980.8 1008.3 10747.2 11144.3 11189.7 11215.3 11379.6 516991.0 522096.0 522788.0 528265.0 528773.0 73930.6 73981.6 93844.0 95702.0 103405.0 975.1 986.2 996.9 1001.3 1006.7 17355.8 17734.6 18500.1 18618.3 18666.5 39669.2 41250.6 41320.8 43461.6 43918.6 59316.6 59854.0 60508.0 61505.7 61926.4 8014.8 8494.6 8509.4 8545.5 8798.9 12903.0 13340.3 13430.5 13720.2 13839.7 11673.4 11859.8 11919.0 11976.9 11988.9 11687.8 11831.8 11898.3 11906.2 12033.8 11882.0 11936.8 11985.6 12147.5 12434.2 8448.5 8481.2 8586.6 8686.1 8827.5 10579.2 11535.4 11794.6 11828.2 12272.4 04:36:58 INFO - PROCESS | 18240 | 04:36:58 INFO - PROCESS | 18240 | [#3] mootools.html Cycles:180 Average:5771.63 Median:459.91 stddev:3291.77 (715.7%) stddev-sans-first:3285.37 04:36:58 INFO - PROCESS | 18240 | Values: 1501.8 1510.1 1681.4 1773.1 1794.2 7754.8 8295.1 8515.1 9124.2 9131.8 8180.3 8489.6 8535.2 8540.3 8572.7 2300.1 2312.5 2319.0 2327.6 2329.6 2286.3 2304.0 2319.4 2331.4 2337.6 2302.1 2322.2 2326.6 2328.6 2343.3 2267.0 2284.5 2299.9 2307.5 2316.7 2190.1 2205.0 2209.9 2213.8 2214.3 8498.4 8522.7 8568.8 8595.7 8604.9 5103.6 5189.1 5206.7 5228.5 5230.4 3108.8 3130.7 3310.2 3311.4 3322.0 1073.3 1082.7 1091.7 1096.7 1113.1 12229.8 12237.9 12285.2 12290.6 12349.0 4468.9 4654.3 4709.0 4745.4 4753.7 10250.4 10264.2 10316.5 10341.7 10347.2 5275.8 5295.8 5298.4 5307.2 5308.7 4308.8 4782.1 4880.1 4892.6 4900.1 3729.2 3895.4 3937.1 3973.4 3982.3 1217.7 1250.3 1252.3 1263.8 1271.4 967.1 987.5 1027.7 1040.3 1060.5 6152.0 6156.9 6193.1 6294.7 6407.1 456.0 456.8 463.1 463.4 464.1 4224.5 4327.6 4344.6 4347.7 4376.4 10566.9 10732.4 10874.3 10898.4 10901.3 10267.2 10760.1 10847.1 10894.1 10917.1 8135.3 8287.3 8347.3 8347.8 8358.9 6126.6 6204.3 6279.2 6365.3 6511.2 10127.6 10190.7 10222.5 10225.8 10234.6 9916.0 10439.7 10582.5 10638.1 10638.9 7050.8 7449.0 7639.0 7771.7 7945.5 8330.5 8458.0 8494.7 8503.1 8542.2 7258.8 7373.9 7434.3 7442.7 7533.6 7419.5 7423.9 7501.6 7574.8 7684.0 6754.6 6761.3 6789.3 6844.4 6861.0 5098.4 5209.2 5219.7 5336.9 5368.7 5173.9 5232.1 5321.6 5338.6 5348.3 04:36:58 INFO - PROCESS | 18240 | 04:36:58 INFO - PROCESS | 18240 | [#4] prototype.html Cycles:180 Average:4899.58 Median:5590.50 stddev:1433.48 (25.6%) stddev-sans-first:1395.93 04:36:58 INFO - PROCESS | 18240 | Values: 333.6 337.2 341.0 346.4 348.5 5559.2 5665.2 5666.4 5703.5 5731.0 5491.3 5497.9 5521.5 5558.0 5561.8 4156.0 4309.4 4313.5 4342.8 4357.3 4318.2 4336.5 4337.7 4368.9 4397.0 4328.4 4365.9 4370.0 4372.8 4378.7 4303.9 4327.4 4333.3 4362.6 4363.9 3865.8 3869.9 3886.6 3887.4 3889.5 5436.5 5444.9 5476.0 5476.9 5493.9 4832.9 4951.4 4970.1 5003.8 5020.8 5695.6 5739.7 5751.1 5777.2 5828.7 4207.6 4228.1 4228.2 4234.1 4234.4 5707.5 5978.4 6033.8 6038.2 6101.5 4173.6 4195.3 4224.6 4225.1 4233.8 4276.6 4294.2 4299.8 4300.0 4302.5 4767.8 4883.8 4887.6 4899.7 4953.3 5817.6 5828.0 5853.0 5857.0 5904.9 1462.7 1479.8 1482.5 1495.1 1505.7 964.9 973.3 1002.7 1004.4 1007.4 5528.8 5555.1 5560.2 5590.5 5590.5 5879.4 5889.4 5902.5 5944.9 5967.0 5448.8 5589.0 5604.9 5612.5 5656.7 3172.3 3182.8 3187.6 3217.9 3229.7 5918.8 6067.8 6138.6 6191.6 6238.7 5946.0 5992.0 5992.9 6023.3 6066.6 6121.5 6162.2 6173.0 6191.8 6210.5 5767.7 5826.2 5833.5 5847.9 5932.2 5850.8 5875.5 5878.4 5881.0 5886.5 5942.8 6016.7 6100.7 6152.1 6162.9 4205.9 4213.3 4215.3 4225.6 4234.3 5911.2 5935.5 5947.5 5955.4 5980.0 5524.4 5727.1 5761.2 5773.3 5842.7 5746.5 5817.8 5821.5 5824.9 5840.2 5639.8 5682.0 5744.9 5787.7 5805.9 5900.7 5903.4 5917.2 5935.9 5941.6 5793.2 5807.3 5813.9 5895.6 5895.6 04:36:58 INFO - PROCESS | 18240 | 04:36:58 INFO - PROCESS | 18240 | [#5] yui.html Cycles:180 Average:20831.60 Median:4727.93 stddev:29880.16 (632.0%) stddev-sans-first:29925.92 04:36:58 INFO - PROCESS | 18240 | Values: 744.3 755.3 767.5 851.6 853.9 13114.0 13687.1 13827.7 13840.4 13905.5 12555.6 12703.0 12709.6 12725.0 12759.2 652.8 774.5 793.0 806.3 806.8 796.2 804.2 806.3 806.4 807.6 858.3 858.9 864.0 865.0 865.3 851.3 854.6 855.2 856.1 856.8 622.9 627.2 628.8 629.3 629.4 13239.9 13322.1 13377.5 13395.9 13412.0 15070.9 15301.1 15403.8 15438.4 15520.4 12177.5 12252.7 12408.2 12427.5 12546.1 3922.2 3944.8 4059.5 4117.5 4123.8 72529.6 73339.0 74541.0 75712.0 75802.2 11547.2 11565.2 11611.8 11651.5 11783.8 21844.2 21880.0 21966.6 21987.7 22121.2 8668.9 8706.3 9246.8 9247.5 9264.0 4862.3 4960.1 5022.7 5061.9 5136.8 3434.7 3539.3 3545.6 3557.5 3568.4 609.2 634.2 639.3 657.1 660.8 639.4 674.7 726.8 775.1 814.0 9411.3 10128.7 10131.7 10157.7 10400.7 603.3 640.8 737.3 778.8 823.7 4593.6 5146.2 5184.9 5186.5 5224.0 90387.0 94080.0 94518.5 108136.0 115321.4 99092.0 105285.0 107478.5 110365.0 110698.4 92756.7 93651.5 94965.0 97433.5 99596.0 9097.9 9305.8 9348.6 9488.6 9529.9 53578.7 55735.9 55833.2 56349.4 57080.0 61781.0 62049.7 64947.4 82030.6 82743.6 12743.5 13184.7 13341.6 13374.7 14109.9 13679.4 13966.3 14042.9 14780.0 15157.6 13322.9 13690.3 13720.2 14134.4 14375.0 14096.2 14574.4 14664.2 14697.0 15302.8 10737.0 13806.5 13847.2 14473.5 14938.4 11659.3 11745.1 12150.6 12177.0 12519.8 10123.9 10139.6 10450.4 11314.4 11458.2 04:36:58 INFO - PROCESS | 18240 | -------- Summary: end -------- 04:36:58 INFO - PROCESS | 18240 | 04:36:59 INFO - TEST-INFO | 18240: exit 0 04:36:59 INFO - TEST-OK | dromaeo_css | took 1112636ms 04:36:59 INFO - TEST-START | kraken 04:36:59 INFO - operating with platform_type : linux_ 04:36:59 INFO - Initialising browser for kraken test... 04:36:59 INFO - TEST-INFO | started process 18486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMlglBf/profile http://localhost:38223/getInfo.html) 04:37:03 INFO - PROCESS | 18486 | __metrics Screen width/height:1600/1200 04:37:03 INFO - PROCESS | 18486 | colorDepth:24 04:37:03 INFO - PROCESS | 18486 | Browser inner width/height: 1024/697 04:37:03 INFO - PROCESS | 18486 | __metrics 04:37:04 ERROR - PROCESS | 18486 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:37:05 INFO - TEST-INFO | 18486: exit 0 04:37:05 INFO - Browser initialized. 04:37:05 INFO - Running cycle 1/1 for kraken test... 04:37:05 INFO - TEST-INFO | started process 18608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMlglBf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:16 INFO - PROCESS | 18608 | RSS: Main: 167403520 04:37:16 INFO - PROCESS | 18608 | 04:37:19 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38223/tests/kraken/driver.html?testName=audio-beat-detection) 04:37:20 INFO - PROCESS | 18608 | RSS: Main: 173158400 04:37:20 INFO - PROCESS | 18608 | 04:37:22 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38223/tests/kraken/driver.html?testName=audio-dft) 04:37:23 INFO - PROCESS | 18608 | RSS: Main: 171728896 04:37:23 INFO - PROCESS | 18608 | 04:37:26 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38223/tests/kraken/driver.html?testName=audio-fft) 04:37:27 INFO - PROCESS | 18608 | RSS: Main: 168009728 04:37:27 INFO - PROCESS | 18608 | 04:37:29 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38223/tests/kraken/driver.html?testName=audio-oscillator) 04:37:29 INFO - PROCESS | 18608 | RSS: Main: 169549824 04:37:29 INFO - PROCESS | 18608 | 04:37:31 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38223/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:37:32 INFO - PROCESS | 18608 | RSS: Main: 169508864 04:37:32 INFO - PROCESS | 18608 | 04:37:35 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38223/tests/kraken/driver.html?testName=imaging-darkroom) 04:37:36 INFO - PROCESS | 18608 | RSS: Main: 169254912 04:37:36 INFO - PROCESS | 18608 | 04:37:39 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38223/tests/kraken/driver.html?testName=imaging-desaturate) 04:37:40 INFO - PROCESS | 18608 | RSS: Main: 167530496 04:37:40 INFO - PROCESS | 18608 | 04:37:43 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38223/tests/kraken/driver.html?testName=json-parse-financial) 04:37:43 INFO - PROCESS | 18608 | RSS: Main: 168644608 04:37:43 INFO - PROCESS | 18608 | 04:37:45 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38223/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:37:46 INFO - PROCESS | 18608 | RSS: Main: 168849408 04:37:46 INFO - PROCESS | 18608 | 04:37:47 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38223/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:37:48 INFO - PROCESS | 18608 | RSS: Main: 169107456 04:37:48 INFO - PROCESS | 18608 | 04:37:50 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38223/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:37:51 INFO - PROCESS | 18608 | RSS: Main: 169684992 04:37:51 INFO - PROCESS | 18608 | 04:37:53 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:37:54 INFO - PROCESS | 18608 | RSS: Main: 169611264 04:37:54 INFO - PROCESS | 18608 | 04:37:57 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:57 INFO - PROCESS | 18608 | RSS: Main: 169738240 04:37:57 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | Cycle 1(1): loaded http://localhost:38223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38223/tests/kraken/driver.html?testName=ai-astar) 04:37:59 INFO - PROCESS | 18608 | RSS: Main: 170426368 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | __start_tp_report 04:37:59 INFO - PROCESS | 18608 | _x_x_mozilla_page_load 04:37:59 INFO - PROCESS | 18608 | _x_x_mozilla_page_load_details 04:37:59 INFO - PROCESS | 18608 | |i|pagename|runs| 04:37:59 INFO - PROCESS | 18608 | |0;ai-astar;104;113;106;111;112;112;121;112;114;113 04:37:59 INFO - PROCESS | 18608 | |1;audio-beat-detection;153;117;145;181;119;142;157;121;178;119 04:37:59 INFO - PROCESS | 18608 | |2;audio-dft;168;163;162;165;166;164;174;166;162;163 04:37:59 INFO - PROCESS | 18608 | |3;audio-fft;75;76;76;173;77;76;75;75;167;76 04:37:59 INFO - PROCESS | 18608 | |4;audio-oscillator;84;85;158;85;86;84;152;85;85;140 04:37:59 INFO - PROCESS | 18608 | |5;imaging-gaussian-blur;117;117;118;118;117;117;119;117;117;117 04:37:59 INFO - PROCESS | 18608 | |6;imaging-darkroom;153;147;147;147;148;147;148;147;148;147 04:37:59 INFO - PROCESS | 18608 | |7;imaging-desaturate;95;97;96;95;95;96;101;96;96;95 04:37:59 INFO - PROCESS | 18608 | |8;json-parse-financial;52;54;52;53;56;55;53;56;52;54 04:37:59 INFO - PROCESS | 18608 | |9;json-stringify-tinderbox;63;65;64;64;65;64;63;64;65;64 04:37:59 INFO - PROCESS | 18608 | |10;stanford-crypto-aes;76;77;77;86;82;77;77;76;79;76 04:37:59 INFO - PROCESS | 18608 | |11;stanford-crypto-ccm;120;126;130;130;120;141;137;128;180;136 04:37:59 INFO - PROCESS | 18608 | |12;stanford-crypto-pbkdf2;161;159;162;159;160;157;160;165;161;156 04:37:59 INFO - PROCESS | 18608 | |13;stanford-crypto-sha256-iterative;67;69;65;69;65;66;63;66;63;74 04:37:59 INFO - PROCESS | 18608 | __end_tp_report 04:37:59 INFO - PROCESS | 18608 | __start_cc_report 04:37:59 INFO - PROCESS | 18608 | _x_x_mozilla_cycle_collect,895 04:37:59 INFO - PROCESS | 18608 | __end_cc_report 04:37:59 INFO - PROCESS | 18608 | __startTimestamp1469101079867__endTimestamp 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | ------- Summary: start ------- 04:37:59 INFO - PROCESS | 18608 | Number of tests: 14 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:4.57 (4.1%) stddev-sans-first:3.87 04:37:59 INFO - PROCESS | 18608 | Values: 104.0 113.0 106.0 111.0 112.0 112.0 121.0 112.0 114.0 113.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:149.00 stddev:24.22 (16.3%) stddev-sans-first:25.43 04:37:59 INFO - PROCESS | 18608 | Values: 153.0 117.0 145.0 181.0 119.0 142.0 157.0 121.0 178.0 119.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:3.62 (2.2%) stddev-sans-first:3.71 04:37:59 INFO - PROCESS | 18608 | Values: 168.0 163.0 162.0 165.0 166.0 164.0 174.0 166.0 162.0 163.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:39.77 (52.3%) stddev-sans-first:41.54 04:37:59 INFO - PROCESS | 18608 | Values: 75.0 76.0 76.0 173.0 77.0 76.0 75.0 75.0 167.0 76.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:85.00 stddev:31.77 (37.4%) stddev-sans-first:32.83 04:37:59 INFO - PROCESS | 18608 | Values: 84.0 85.0 158.0 85.0 86.0 84.0 152.0 85.0 85.0 140.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 04:37:59 INFO - PROCESS | 18608 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 119.0 117.0 117.0 117.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:147.50 stddev:1.85 (1.3%) stddev-sans-first:0.50 04:37:59 INFO - PROCESS | 18608 | Values: 153.0 147.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 147.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.81 (1.9%) stddev-sans-first:1.87 04:37:59 INFO - PROCESS | 18608 | Values: 95.0 97.0 96.0 95.0 95.0 96.0 101.0 96.0 96.0 95.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.57 (2.9%) stddev-sans-first:1.54 04:37:59 INFO - PROCESS | 18608 | Values: 52.0 54.0 52.0 53.0 56.0 55.0 53.0 56.0 52.0 54.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 04:37:59 INFO - PROCESS | 18608 | Values: 63.0 65.0 64.0 64.0 65.0 64.0 63.0 64.0 65.0 64.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:77.00 stddev:3.27 (4.2%) stddev-sans-first:3.36 04:37:59 INFO - PROCESS | 18608 | Values: 76.0 77.0 77.0 86.0 82.0 77.0 77.0 76.0 79.0 76.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:133.00 stddev:17.31 (13.0%) stddev-sans-first:17.51 04:37:59 INFO - PROCESS | 18608 | Values: 120.0 126.0 130.0 130.0 120.0 141.0 137.0 128.0 180.0 136.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:160.50 stddev:2.54 (1.6%) stddev-sans-first:2.67 04:37:59 INFO - PROCESS | 18608 | Values: 161.0 159.0 162.0 159.0 160.0 157.0 160.0 165.0 161.0 156.0 04:37:59 INFO - PROCESS | 18608 | 04:37:59 INFO - PROCESS | 18608 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:3.30 (5.0%) stddev-sans-first:3.50 04:37:59 INFO - PROCESS | 18608 | Values: 67.0 69.0 65.0 69.0 65.0 66.0 63.0 66.0 63.0 74.0 04:37:59 INFO - PROCESS | 18608 | -------- Summary: end -------- 04:37:59 INFO - PROCESS | 18608 | 04:38:00 INFO - TEST-INFO | 18608: exit 0 04:38:00 INFO - TEST-OK | kraken | took 61665ms 04:38:00 INFO - SUITE-END | took 1174s 04:38:01 INFO - Completed test suite (00:19:34) 04:38:01 INFO - javascript benchmark 04:38:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7243.6517742836595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3042.5436184572313, 3069.5088785794264, 3084.151858238984, 3105.7981231219983, 3106.409782141393, 5388.892222155555, 5402.486763757442, 5461.180822876566, 5493.395726470085, 5514.290569923327, 5266.605004624659, 5404.243405923174, 5413.188021796733, 5441.211024401459, 5496.258005169301, 4854.34466347044, 4885.291632713254, 4914.017196560684, 5040.470750571192, 5044.419891712445, 4932.630052746058, 5063.265826455162, 5069.949300506984, 5111.7699703513435, 5112.795488180468, 4885.340479035356, 4922.163232250526, 4925.458199598042, 4966.950330496685, 4971.502849715036, 4957.5786058185095, 5003.74981250936, 5004.174311238678, 5008.5993120550265, 5026.924596131061, 4878.682885612424, 4933.70397776131, 4936.555709986119, 4949.678270912379, 5004.84985450437, 5329.094054010828, 5329.467053294678, 5406.8918621627745, 5411.810586629449, 5490.121580547093, 5785.016547186989, 5798.304203495608, 5799.739011744439, 5800.53595712342, 5844.912326315109, 5771.769129234825, 5796.188533605298, 5830.533557315404, 5842.4741773240185, 5849.707514624294, 5313.893722125575, 5377.892442151135, 5396.649217800869, 5409.594280428944, 5421.078416669176, 5938.198343223696, 5973.820785376446, 5978.880422391615, 5994.6403215807195, 6025.186599809057, 5709.800156994485, 5710.457506536873, 5725.227094342294, 5728.51307638847, 5729.0260655688635, 5531.668099914018, 5569.220309156722, 5739.426057394227, 5784.537237021028, 5813.912791308134, 5538.556915446755, 5559.332880054339, 5575.4424557544735, 5691.203231547586, 5857.88284234313, 5673.035583950738, 5700.287464066992, 5705.657660540381, 5720.48515633595, 5723.828285151452, 4410.33844923264, 4412.205802955435, 4429.291313389842, 4437.179121862466, 4451.844185453494, 3870.2259548090497, 3928.1161738609158, 3934.075492259317, 3946.782926939046, 3989.501312335958, 5405.162199859028, 5436.972815135899, 5460.808871689551, 5476.58925580583, 5480.0, 5786.739596718157, 5801.216835727208, 5803.7968671096305, 5811.476967072984, 5820.738066787005, 5466.9179962300595, 5567.498925096761, 5590.133529302964, 5641.0, 5659.320881494247, 5022.121128802518, 5048.545630893237, 5061.291419201315, 5067.695938243717, 5083.694978301313, 6099.878002439927, 6109.266887973472, 6116.541259405562, 6119.2350956130485, 6121.449069583669, 5692.829215123553, 5700.743466544015, 5724.313082429969, 5737.770489180386, 5833.0375488044, 5979.641221526722, 5979.790707325223, 5992.041273396236, 6000.51995840323, 6007.219061522149, 5609.943900560942, 5626.774929002794, 5644.717764111696, 5662.886742265049, 5678.602497825113, 5653.038983372754, 5734.799282025109, 5815.331236907809, 5819.5635327351465, 5896.262967129109, 5691.288588926384, 5694.316681998187, 5698.344690360662, 5699.658020518782, 5720.2849643794525, 5654.010548154139, 5663.405342438985, 5675.545956323567, 5680.488756011813, 5697.857553561194, 5491.341039075336, 5614.887702246014, 5660.264165658438, 5681.0910254359105, 5767.567432442667, 5704.543636509153, 5723.399043100581, 5733.627314224562, 5775.393583673822, 5785.0454674978155, 5610.8316750495915, 5614.550835933197, 5626.662400255997, 5643.35101463337, 5650.85872853182], "value": 5348.224495066723, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.471479038753, 590.7194082810665, 597.8355952113168, 608.2943785209156, 627.9811605651832, 39252.60747392525, 44173.7791311043, 44174.33738493925, 44213.115737685264, 44277.33583996238, 44273.114537709225, 44591.554084459145, 44668.0, 44683.77658111705, 44932.775336123355, 8870.512121833313, 9053.637854485813, 9059.682911098113, 9066.592003359865, 9068.183863452288, 8958.32812539059, 9005.0, 9041.0, 9045.683401080963, 9046.502442365667, 8971.237444817198, 9025.052369501207, 9072.138146876036, 9099.04460031697, 9107.271418286522, 8946.194842464209, 8960.462372257685, 8962.641494340218, 8996.370254082216, 9010.23413009895, 8885.555722213929, 8897.154770296811, 8932.508712020835, 8973.0, 8994.370394072417, 42163.7891810539, 42551.57448425507, 42671.57328426738, 42697.14605707869, 42744.0, 3522.454019626962, 3786.7159963002887, 4008.959910400888, 4238.894027649302, 4437.334399840018, 33015.6698433015, 33442.665573344195, 33479.83260083684, 33694.49458258128, 33827.15432114192, 4482.238019536687, 4505.684602077856, 4572.474165470981, 4685.250359942427, 4702.247640377557, 379299.0, 379621.0, 382365.0, 383365.0, 383673.0, 30829.69170308268, 31499.212519686735, 31591.21021974469, 57678.42321576815, 57778.7111064442, 35868.28263434717, 35962.640373596456, 36184.63815361865, 36288.274234515164, 36383.81808090943, 14467.49363772284, 14580.635484112981, 14613.634659133606, 14621.26893655313, 14729.852701473063, 12064.577739779066, 12183.086268529896, 12192.57325993586, 12198.939005304917, 12269.69325766863, 8068.798280042928, 8072.475289106189, 8245.95877020611, 8246.257836794597, 8318.916810831935, 3232.466643003878, 3253.1053960161144, 3285.852136653856, 3288.8191149487006, 3293.061477478907, 947.8104379124203, 1028.9382637041801, 1055.5935964653663, 1096.8135416979133, 1135.03522006294, 32601.0, 33023.66976330254, 33619.66380336214, 33626.0, 33956.83021584926, 1089.716673664837, 1116.7264020315074, 1128.514738662383, 1164.5225457562358, 1168.485866218878, 17309.91345043292, 17551.848243224566, 17562.736558951627, 17564.91217543904, 17606.735898961524, 582984.0, 583968.0, 584290.0, 588110.0, 590077.0, 59141.408585914454, 59709.70145149247, 59719.402805972255, 59757.701211493666, 59771.70114149401, 1289.220021886745, 1332.373784321387, 1344.1196016608942, 1349.743548725739, 1352.1684164238923, 29476.263093422836, 30960.22599434942, 32062.519062213618, 32164.678353217103, 32617.673823261463, 50728.492715072374, 51036.489635104655, 51086.489135108175, 51094.48905510897, 51133.0, 477307.0, 478660.0, 478920.0, 479913.0, 482787.0, 27940.860295698392, 28277.858610706815, 28383.14850554487, 28431.147065588066, 28505.857470712515, 46900.7654961723, 47126.76436617795, 47461.52538474571, 48086.519134809605, 48491.27263090986, 40472.39291410572, 41743.16513669649, 42418.5758142427, 42472.36291455692, 42816.785916071465, 40710.79644601758, 41167.0, 41306.586934130275, 41549.16901661889, 42956.78521607372, 41785.58214417939, 42209.36685949652, 42323.0, 42477.0, 44901.0, 33691.83154084214, 39559.0, 40001.1999760009, 40754.1849163021, 40908.795456022526, 28906.27734306659, 28974.710252897203, 29075.563866541597, 29473.557896631995, 29485.115446536638], "value": 19136.5023241991, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.68947463080286, 386.80852977776, 387.1237580184713, 394.9842006319747, 409.93441049432096, 18614.162362693678, 19515.316963906265, 19927.302544410948, 20154.39536813896, 20274.0, 18912.43262702121, 19160.61678766424, 19295.517612059706, 19875.403737887886, 20082.698759518582, 5827.155062515943, 5890.440408161239, 5916.763329466838, 5931.228940237785, 5935.762569497237, 5659.8585035374235, 5832.562557808182, 5835.0663893777, 5846.619969701956, 5871.236739223895, 5652.773889044433, 5743.856403589902, 5772.711364431782, 5831.037878750022, 5850.414958504158, 5796.333421656522, 5826.9708651456685, 5829.621074630136, 5835.79574714883, 5839.182514447981, 5081.974590127025, 5169.612279079084, 5200.765965531522, 5208.687478751287, 5219.060569097561, 23606.763932360627, 23743.0, 23877.641835372484, 23886.163984260642, 24248.636270455958, 2286.2455389721354, 2300.344401845483, 2323.3959170615594, 2353.5881220786464, 2427.5509030829353, 14405.927970360186, 14752.778708319276, 14949.775753363709, 14965.850341496554, 15231.086134831945, 1910.2836436336374, 1947.6494231038407, 1975.802419758027, 2021.6765317549268, 2048.8463365247517, 80754.19245807525, 81079.0, 81936.0, 81939.5903020487, 85039.5748021256, 8935.693793296521, 9648.517574121266, 9657.420554766737, 10274.280800344053, 10579.947100264604, 12080.57717979884, 12923.612291631267, 12946.611601651966, 12988.350582470839, 13021.153625014344, 6890.0, 6962.512624116263, 7068.92931070693, 7083.858322833515, 7198.676059577331, 6853.246142924274, 6862.4853136015, 7034.437245020386, 7057.964710176519, 7111.964440177766, 3768.1898391845884, 3790.033541446913, 3829.5404551454003, 3853.9807300963316, 3929.980350098231, 1784.9107544622716, 1848.6395152945315, 1859.841913437373, 1862.720591911197, 1878.7181922711702, 848.9151084891462, 931.5575101826578, 977.2768151567931, 1049.5906596427399, 1050.6165249683963, 20136.0, 20486.692699609517, 20672.0, 20761.169553217704, 20835.479113022295, 952.9809403812023, 968.6270785747538, 975.9024097590184, 980.8332583460829, 1008.2841182760176, 10747.247692661438, 11144.322373616687, 11189.69587695607, 11215.327080375204, 11379.601713939972, 516991.0, 522096.0, 522788.0, 528265.0, 528773.0, 73930.63034684792, 73981.57503123049, 93844.0, 95702.0, 103405.0, 975.1321324021626, 986.2455221755363, 996.9302148849656, 1001.2590682894605, 1006.6979906028163, 17355.826441735928, 17734.556636084202, 18500.0749962504, 18618.255269789057, 18666.533336666147, 39669.20661586694, 41250.58749412587, 41320.79339603283, 43461.565384345755, 43918.56081439145, 59316.62733490785, 59854.0, 60508.0, 61505.69247153735, 61926.38073619206, 8014.83970320602, 8494.617742201739, 8509.361797865062, 8545.529995850287, 8798.912010880065, 12903.0, 13340.266285354399, 13430.462781489023, 13720.176789392668, 13839.654008649864, 11673.416329183337, 11859.822102668295, 11919.0, 11976.940115299367, 11988.940055299669, 11687.824682629598, 11831.822522661994, 11898.345590992578, 11906.226095303777, 12033.819492707791, 11882.0, 11936.820947685617, 11985.580504682293, 12147.514099435924, 12434.191777534432, 8448.450850694686, 8481.236688698047, 8586.570671466277, 8686.087960764282, 8827.470351778913, 10579.206559507913, 11535.423228838692, 11794.587189448672, 11828.23116497425, 12272.447739851907], "value": 9188.48749605935, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.8122734658168, 1510.1392206442329, 1681.403101898826, 1773.1400270868635, 1794.2284817528466, 7754.806129846756, 8295.087540370554, 8515.063343032269, 9124.178823905848, 9131.817363652732, 8180.263776260135, 8489.617967191476, 8535.231829135377, 8540.274076703472, 8572.742817715478, 2300.0684722687297, 2312.537492501498, 2318.9652155217686, 2327.627579587266, 2329.5923213437663, 2286.2912497125944, 2303.9539209215804, 2319.373769082347, 2331.428799944016, 2337.637666161748, 2302.1482051640915, 2322.2336628912503, 2326.581215381231, 2328.639060945556, 2343.3087239264373, 2266.9546609067725, 2284.451731584416, 2299.9195028174017, 2307.457747429353, 2316.745158032615, 2190.113004233272, 2204.9889750551147, 2209.9116035358566, 2213.7786221377896, 2214.2803588833694, 8498.447600905922, 8522.74431767048, 8568.785780355542, 8595.699150529701, 8604.913950860473, 5103.642745007851, 5189.143791274435, 5206.739663016872, 5228.451012643655, 5230.372355317349, 3108.782385233035, 3130.733887619555, 3310.1724568857785, 3311.3542859142476, 3322.0, 1073.2701762801291, 1082.7455547946226, 1091.6779550032759, 1096.7203363142428, 1113.0761467981556, 12229.816552751716, 12237.938810305892, 12285.201461904948, 12290.569830055905, 12348.99999999991, 4468.865934021985, 4654.2785868190485, 4708.987567672898, 4745.406824146981, 4753.667243292936, 10250.436226007492, 10264.230182736324, 10316.484175791331, 10341.689749307532, 10347.223958203165, 5275.762590683428, 5295.761690723926, 5298.3906850712665, 5307.203919412042, 5308.681479111266, 4308.763018034038, 4782.115308667908, 4880.145974454456, 4892.633052521075, 4900.142475066849, 3729.179580492287, 3895.415687646819, 3937.1338305572726, 3973.443717879499, 3982.3230050891416, 1217.697064141378, 1250.337321219755, 1252.3300034481508, 1263.8420197475316, 1271.3960868587533, 967.1489089601106, 987.4865070163619, 1027.6968294353185, 1040.2770074797943, 1060.5280650110626, 6152.020423630811, 6156.8768624627255, 6193.102000209944, 6294.653794041372, 6407.103005579223, 455.9886002849889, 456.7533531892807, 463.0622988448419, 463.3536216977298, 464.13438936383403, 4224.493060832659, 4327.588879056485, 4344.630706389992, 4347.695661303678, 4376.365427013129, 10566.947165264124, 10732.356058636507, 10874.347539147677, 10898.400587967737, 10901.29141605809, 10267.229957753198, 10760.085392741705, 10847.132229421628, 10894.074003709615, 10917.126629869592, 8135.30849877767, 8287.295579875778, 8347.332213422911, 8347.791305217419, 8358.874616880752, 6126.6017708848785, 6204.255489341308, 6279.183706118175, 6365.267994180728, 6511.186101737283, 10127.64553240633, 10190.745231369276, 10222.48887555634, 10225.795484090426, 10234.6417875374, 9915.950420247853, 10439.686809395731, 10582.523786429476, 10638.14894808429, 10638.946805266234, 7050.823729406806, 7448.9627551861895, 7639.04511936008, 7771.72798952034, 7945.523268603903, 8330.458520196167, 8457.957710211409, 8494.70268540598, 8503.064662887202, 8542.18849209324, 7258.782236532912, 7373.926260737324, 7434.293742094493, 7442.7395041173295, 7533.58565278893, 7419.4806363554035, 7423.925760742323, 7501.6249187539315, 7574.810629734301, 7683.961580192064, 6754.5947243165565, 6761.290064543152, 6789.253182150058, 6844.4182244509775, 6861.0, 5098.362704661918, 5209.244659524272, 5219.739013049257, 5336.866578335573, 5368.651037682538, 5173.919770802218, 5232.136697445031, 5321.574274058144, 5338.599605029716, 5348.251244825806], "value": 4546.571957447, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.644668428124, 337.15038103977975, 340.9505621684856, 346.4387691939059, 348.491202843848, 5559.249501317321, 5665.206871038058, 5666.37669856316, 5703.486686198241, 5731.0, 5491.341039075317, 5497.890042199164, 5521.475459831319, 5558.0, 5561.77752889885, 4155.979220103895, 4309.37514060461, 4313.482382114151, 4342.804573794171, 4357.281048626973, 4318.244307246235, 4336.457942757155, 4337.7397356158735, 4368.929612245004, 4397.0, 4328.350747387885, 4365.869023929287, 4370.0, 4372.797480692803, 4378.737275763448, 4303.924018995252, 4327.437433133704, 4333.285007973696, 4362.629176519999, 4363.869083927487, 3865.845366185349, 3869.916423401452, 3886.6113388661192, 3887.4168874668744, 3889.533256009297, 5436.510714035716, 5444.91832622511, 5476.014317422862, 5476.890462190734, 5493.945060549383, 4832.921843607248, 4951.356323677935, 4970.061675946384, 5003.824866129668, 5020.799168033274, 5695.629784064023, 5739.713014349266, 5751.130882463216, 5777.220075289866, 5828.6502809831545, 4207.600277973587, 4228.112096459748, 4228.217779710732, 4234.110836724291, 4234.364845273203, 5707.5148612368, 5978.40215978403, 6033.7586496540525, 6038.245219347582, 6101.511879049665, 4173.561776013536, 4195.328747400462, 4224.640905523003, 4225.112726327444, 4233.830646774095, 4276.5723427656985, 4294.162638285505, 4299.78501074945, 4299.9785001075425, 4302.483701955723, 4767.809287628525, 4883.804647814119, 4887.608991280689, 4899.706017638953, 4953.2570114483115, 5817.621854579439, 5827.970860145672, 5853.0, 5856.970715146482, 5904.881902361929, 1462.7367073926796, 1479.8446163152714, 1482.5033613739517, 1495.110409306461, 1505.6762795998693, 964.8697425847561, 973.3381300715581, 1002.6941782756329, 1004.4080132989147, 1007.4459047523833, 5528.806491772769, 5555.111182210827, 5560.221568980346, 5590.468905453975, 5590.5248053915875, 5879.441453061952, 5889.411058894162, 5902.527797776168, 5944.910826337608, 5967.045272756338, 5448.754806033738, 5589.0, 5604.935062338142, 5612.494875461147, 5656.745446454837, 3172.3179516404084, 3182.8249446280215, 3187.5974571188603, 3217.9380804334983, 3229.7416206703406, 5918.844401822057, 6067.848303792441, 6138.570300079041, 6191.628502289877, 6238.691684076921, 5946.0, 5991.9700401498585, 5992.910106348409, 6023.343580515393, 6066.636001839904, 6121.540884433685, 6162.198914141133, 6173.0, 6191.783287584913, 6210.534209934273, 5767.711614419179, 5826.213461182686, 5833.533317334688, 5847.912281315868, 5932.1694962706115, 5850.765969361178, 5875.529957603467, 5878.353381128158, 5881.0, 5886.499647529837, 5942.7920022799, 6016.699165041643, 6100.694965251809, 6152.138700581832, 6162.876742465215, 4205.894852628709, 4213.325867861127, 4215.346621273708, 4225.598568136023, 4234.343676730112, 5911.201987731602, 5935.495482884004, 5947.51312171957, 5955.409396912357, 5980.0431930890845, 5524.4199359068325, 5727.11229759388, 5761.193432919478, 5773.3072031356505, 5842.678652674143, 5746.511546518593, 5817.76728930838, 5821.505172060422, 5824.912626310694, 5840.240768700041, 5639.802606908738, 5681.971590142023, 5744.913826292525, 5787.710614469175, 5805.883882322414, 5900.734466948912, 5903.380145084704, 5917.201177841109, 5935.910961335497, 5941.58408911372, 5793.217915581343, 5807.332156802022, 5813.912791308218, 5895.587308888336, 5895.616784908967], "value": 4439.833871354932, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.3412579866816, 755.2598453515556, 767.4781148818801, 851.6423102297034, 853.9316854651629, 13113.950883929287, 13687.110337828059, 13827.723445531083, 13840.377183026776, 13905.513307034256, 12555.623331300052, 12703.047271454654, 12709.618711438648, 12725.0, 12759.170653907513, 652.7552167937024, 774.4578794843632, 793.0443815202667, 806.3025482957229, 806.822499050208, 796.2316364708056, 804.2440106300088, 806.2985202873508, 806.3549160671469, 807.5598798654747, 858.2618947704968, 858.8840506531601, 864.0107077396377, 865.0095640491634, 865.3293697384514, 851.3487182305541, 854.5727136431784, 855.1875718067829, 856.1139220906363, 856.8414843254018, 622.9345918678519, 627.1971875998729, 628.8239292997922, 629.2731894661673, 629.3863483103983, 13239.86760132396, 13322.134061285986, 13377.464901403931, 13395.86604133956, 13412.0, 15070.924645376812, 15301.12429046005, 15403.845961540354, 15438.382464701399, 15520.379184832593, 12177.51289948401, 12252.693682657915, 12408.193467424588, 12427.502899883993, 12546.121771476, 3922.195949830278, 3944.8027598619956, 4059.533153687334, 4117.505899292074, 4123.814428350732, 72529.63735181344, 73339.0, 74541.0, 75712.0, 75802.24197758007, 11547.249428787101, 11565.248258863146, 11611.76776464466, 11651.475683594259, 11783.764324713458, 21844.235451759112, 21880.01539930707, 21966.560668786537, 21987.670184947237, 22121.225757098746, 8668.8699669505, 8706.347023973227, 9246.815063698688, 9247.537623118817, 9264.0, 4862.270659401118, 4960.082384758831, 5022.673526220857, 5061.8734531637, 5136.8278620428855, 3434.7252219822353, 3539.2567560812518, 3545.556805399325, 3557.537520122419, 3568.357695614762, 609.2080295615682, 634.1724050114644, 639.2584601861818, 657.1227411405731, 660.831487970574, 639.4309064932214, 674.6828990374516, 726.822547473097, 775.1163673412315, 813.9755807325789, 9411.341206115507, 10128.696139115838, 10131.746706332253, 10157.746056348502, 10400.687979360631, 603.2657847921353, 640.8077576726963, 737.2516895351223, 778.7858338956719, 823.6911158315631, 4593.586577208067, 5146.2280657900865, 5184.948150518522, 5186.533212010937, 5224.0, 90387.0, 94080.0, 94518.52740736252, 108136.0, 115321.42339288417, 99092.0, 105285.0, 107478.46260768647, 110365.0, 110698.44650776856, 92756.6519013292, 93651.53174234221, 94965.0, 97433.5128324368, 99596.0, 9097.90902090997, 9305.767355815888, 9348.579313930753, 9488.573014214515, 9529.904700953179, 53578.732106339216, 55735.88528229494, 55833.16250256168, 56349.43650563442, 57080.0, 61781.0, 62049.689751550955, 64947.35052649413, 82030.58984705278, 82743.58628206821, 12743.470783506038, 13184.670383240496, 13341.599752007456, 13374.732505349644, 14109.929450352682, 13679.38442770058, 13966.301684915918, 14042.929785351416, 14780.0, 15157.621059473602, 13322.933385333012, 13690.315484225948, 13720.176789392668, 14134.434622614981, 14375.0, 14096.154230746188, 14574.417023318949, 14664.193469359288, 14696.999003139248, 15302.846971530142, 10737.0, 13806.516771912935, 13847.238401887993, 14473.493427729978, 14938.402463901322, 11659.317384813323, 11745.077750988716, 12150.635480935585, 12177.0, 12519.812202816784, 10123.949380253347, 10139.64511242103, 10450.425226612306, 11314.377709225742, 11458.19792614509], "value": 7609.156933393039, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 106.0, 111.0, 112.0, 112.0, 121.0, 112.0, 114.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 117.0, 145.0, 181.0, 119.0, 142.0, 157.0, 121.0, 178.0, 119.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 162.0, 165.0, 166.0, 164.0, 174.0, 166.0, 162.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 173.0, 77.0, 76.0, 75.0, 75.0, 167.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 158.0, 85.0, 86.0, 84.0, 152.0, 85.0, 85.0, 140.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 101.0, 96.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 52.0, 53.0, 56.0, 55.0, 53.0, 56.0, 52.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 65.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 86.0, 82.0, 77.0, 77.0, 76.0, 79.0, 76.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 126.0, 130.0, 130.0, 120.0, 141.0, 137.0, 128.0, 180.0, 136.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 162.0, 159.0, 160.0, 157.0, 160.0, 165.0, 161.0, 156.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 65.0, 69.0, 65.0, 66.0, 63.0, 66.0, 63.0, 74.0], "value": 66.7, "unit": "score"}]}]} 04:38:01 INFO - Return code: 0 04:38:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:38:01 ERROR - # TBPL SUCCESS # 04:38:01 INFO - Running post-action listener: _resource_record_post_action 04:38:01 INFO - [mozharness: 2016-07-21 11:38:01.161003Z] Finished run-tests step (success) 04:38:01 INFO - Running post-run listener: _resource_record_post_run 04:38:01 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559636480; Read time: 20; Write time: 509312 04:38:01 INFO - TinderboxPrint: CPU usage
13.3% 04:38:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:38:01 INFO - TinderboxPrint: I/O write bytes / time
559,636,480 / 509,312 04:38:01 INFO - TinderboxPrint: CPU idle
8,241.5 (86.7%) 04:38:01 INFO - TinderboxPrint: CPU user
1,211.8 (12.7%) 04:38:01 INFO - TinderboxPrint: Swap in / out
0 / 0 04:38:01 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 265121792; Read time: 0; Write time: 296496 04:38:01 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294514688; Read time: 0; Write time: 212816 04:38:01 INFO - Running post-run listener: _upload_blobber_files 04:38:01 INFO - Blob upload gear active. 04:38:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:38:01 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 04:38:01 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:38:01 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:38:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:38:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:38:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:38:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:25 INFO - (blobuploader) - INFO - Done attempting. 04:38:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:38:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:38:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:26 INFO - (blobuploader) - INFO - Done attempting. 04:38:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:38:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:38:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:27 INFO - (blobuploader) - INFO - Done attempting. 04:38:27 INFO - (blobuploader) - INFO - Iteration through files over. 04:38:27 INFO - Return code: 0 04:38:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:38:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:38:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cdcafd39d346ad3df748822dccc49c5b24b53ce479d38a5b0454f3653b77a3399cc3973b32f29c19c947fe300f0dc7ebbf8c7b1f9d3ea147676fea08bf81b85c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ebdd9f6944eddb843d66955286760e2efc23ea512539721c6d2afafa6a9c5a8ff448659c180c4b047e11627e9a6b5e633be2d8fad6ddc8ed5c3a2201e5168ac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2d269efc6ce0b3db84d2d91aa076629d9c555def199d88689a045d2ebbf8cb576ec2c454b8c2b04b71e84fd9c960beb3eab385824421ab0aad753e89a7de9503"} 04:38:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:38:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:38:27 INFO - Contents: 04:38:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cdcafd39d346ad3df748822dccc49c5b24b53ce479d38a5b0454f3653b77a3399cc3973b32f29c19c947fe300f0dc7ebbf8c7b1f9d3ea147676fea08bf81b85c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ebdd9f6944eddb843d66955286760e2efc23ea512539721c6d2afafa6a9c5a8ff448659c180c4b047e11627e9a6b5e633be2d8fad6ddc8ed5c3a2201e5168ac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2d269efc6ce0b3db84d2d91aa076629d9c555def199d88689a045d2ebbf8cb576ec2c454b8c2b04b71e84fd9c960beb3eab385824421ab0aad753e89a7de9503"} 04:38:27 INFO - Running post-run listener: copy_logs_to_upload_dir 04:38:27 INFO - Copying logs to upload dir... 04:38:27 INFO - mkdir: /builds/slave/test/build/upload/logs 04:38:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.393459 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-21 04:38:26.773890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 04:38:26.777493) ========= 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=cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cdcafd39d346ad3df748822dccc49c5b24b53ce479d38a5b0454f3653b77a3399cc3973b32f29c19c947fe300f0dc7ebbf8c7b1f9d3ea147676fea08bf81b85c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ebdd9f6944eddb843d66955286760e2efc23ea512539721c6d2afafa6a9c5a8ff448659c180c4b047e11627e9a6b5e633be2d8fad6ddc8ed5c3a2201e5168ac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2d269efc6ce0b3db84d2d91aa076629d9c555def199d88689a045d2ebbf8cb576ec2c454b8c2b04b71e84fd9c960beb3eab385824421ab0aad753e89a7de9503"} build_url:https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cdcafd39d346ad3df748822dccc49c5b24b53ce479d38a5b0454f3653b77a3399cc3973b32f29c19c947fe300f0dc7ebbf8c7b1f9d3ea147676fea08bf81b85c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ebdd9f6944eddb843d66955286760e2efc23ea512539721c6d2afafa6a9c5a8ff448659c180c4b047e11627e9a6b5e633be2d8fad6ddc8ed5c3a2201e5168ac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2d269efc6ce0b3db84d2d91aa076629d9c555def199d88689a045d2ebbf8cb576ec2c454b8c2b04b71e84fd9c960beb3eab385824421ab0aad753e89a7de9503"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 04:38:26.807433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:38:26.808232) ========= 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=cbe409c6de289db6ac707de3000001d4-1469099855.454522-541414260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:38:26.891279) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 04:38:26.892053) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 04:38:26.892831) ========= ========= Total master_lag: 0.18 =========