builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1469391434.23 results: success (0) buildid: 20160724103056 builduid: 35f7745b06e74f5c90b1180c253ef941 revision: 07322a610cf811ce8b9a6b76f8b731af1f30d9d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:14.230716) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:14.231520) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:14.231801) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:14.286359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:14.286635) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-24 13:17:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.7M=0s 2016-07-24 13:17:14 (34.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129645 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:14.431085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:14.431356) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017819 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:14.481095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-24 13:17:14.481398) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 07322a610cf811ce8b9a6b76f8b731af1f30d9d7 --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 07322a610cf811ce8b9a6b76f8b731af1f30d9d7 --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=d6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-24 13:17:15,013 truncating revision to first 12 chars 2016-07-24 13:17:15,013 Setting DEBUG logging. 2016-07-24 13:17:15,013 attempt 1/10 2016-07-24 13:17:15,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/07322a610cf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-24 13:17:16,192 unpacking tar archive at: mozilla-inbound-07322a610cf8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499044 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-24 13:17:15.993904) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:15.994214) ========= script_repo_revision: 07322a610cf811ce8b9a6b76f8b731af1f30d9d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:15.994595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:15.994853) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-24 13:17:16.005186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-24 13:17:16.005459) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=d6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:17:16 INFO - MultiFileLogger online at 20160724 13:17:16 in /builds/slave/test 13:17:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:17:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:17:16 INFO - {'append_to_log': False, 13:17:16 INFO - 'base_work_dir': '/builds/slave/test', 13:17:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:17:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:17:16 INFO - 'branch': 'Mozilla-Inbound', 13:17:16 INFO - 'buildbot_json_path': 'buildprops.json', 13:17:16 INFO - 'config_files': ('talos/linux_config.py',), 13:17:16 INFO - 'default_actions': ('clobber', 13:17:16 INFO - 'read-buildbot-config', 13:17:16 INFO - 'download-and-extract', 13:17:16 INFO - 'populate-webroot', 13:17:16 INFO - 'create-virtualenv', 13:17:16 INFO - 'install', 13:17:16 INFO - 'run-tests'), 13:17:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:17:16 INFO - 'download_minidump_stackwalk': True, 13:17:16 INFO - 'download_symbols': 'ondemand', 13:17:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:17:16 INFO - 'tooltool.py': '/tools/tooltool.py', 13:17:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:17:16 INFO - '/tools/misc-python/virtualenv.py')}, 13:17:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:17:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:17:16 INFO - 'installer_path': 'installer.exe', 13:17:16 INFO - 'log_level': 'info', 13:17:16 INFO - 'log_name': 'talos', 13:17:16 INFO - 'log_to_console': True, 13:17:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:17:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:17:16 INFO - 'opt_config_files': (), 13:17:16 INFO - 'pip_index': False, 13:17:16 INFO - 'sps_profile': False, 13:17:16 INFO - 'sps_profile_interval': 0, 13:17:16 INFO - 'suite': 'dromaeojs', 13:17:16 INFO - 'system_bits': '32', 13:17:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:17:16 INFO - 'title': 'talos-linux64-ix-034', 13:17:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:17:16 INFO - 'use_talos_json': True, 13:17:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:17:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:17:16 INFO - 'work_dir': 'build'} 13:17:16 INFO - [mozharness: 2016-07-24 20:17:16.626374Z] Running clobber step. 13:17:16 INFO - Running pre-action listener: _resource_record_pre_action 13:17:16 INFO - Running main action method: clobber 13:17:16 INFO - rmtree: /builds/slave/test/build 13:17:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:17:17 INFO - Running post-action listener: _resource_record_post_action 13:17:17 INFO - [mozharness: 2016-07-24 20:17:17.097766Z] Finished clobber step (success) 13:17:17 INFO - [mozharness: 2016-07-24 20:17:17.097865Z] Running read-buildbot-config step. 13:17:17 INFO - Running pre-action listener: _resource_record_pre_action 13:17:17 INFO - Running main action method: read_buildbot_config 13:17:17 INFO - Using buildbot properties: 13:17:17 INFO - { 13:17:17 INFO - "project": "", 13:17:17 INFO - "product": "firefox", 13:17:17 INFO - "script_repo_revision": "production", 13:17:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:17:17 INFO - "repository": "", 13:17:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:17:17 INFO - "buildid": "20160724103056", 13:17:17 INFO - "pgo_build": "True", 13:17:17 INFO - "basedir": "/builds/slave/test", 13:17:17 INFO - "buildnumber": 1386, 13:17:17 INFO - "slavename": "talos-linux64-ix-034", 13:17:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:17:17 INFO - "platform": "ubuntu64_hw", 13:17:17 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:17:17 INFO - "branch": "mozilla-inbound", 13:17:17 INFO - "repo_path": "integration/mozilla-inbound", 13:17:17 INFO - "revision": "07322a610cf811ce8b9a6b76f8b731af1f30d9d7", 13:17:17 INFO - "stage_platform": "linux64-pgo", 13:17:17 INFO - "builduid": "35f7745b06e74f5c90b1180c253ef941", 13:17:17 INFO - "slavebuilddir": "test" 13:17:17 INFO - } 13:17:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:17:17 INFO - Running post-action listener: _resource_record_post_action 13:17:17 INFO - [mozharness: 2016-07-24 20:17:17.100273Z] Finished read-buildbot-config step (success) 13:17:17 INFO - [mozharness: 2016-07-24 20:17:17.100363Z] Running download-and-extract step. 13:17:17 INFO - Running pre-action listener: _resource_record_pre_action 13:17:17 INFO - Running main action method: download_and_extract 13:17:17 INFO - mkdir: /builds/slave/test/build/tests 13:17:17 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')]} 13:17:17 INFO - https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/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 13:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/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 13:17:19 INFO - Downloaded 1361 bytes. 13:17:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:17:19 INFO - Using the following test package requirements: 13:17:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:17:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:17:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:17:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'jsshell-linux-x86_64.zip'], 13:17:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:17:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:17:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:17:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:17:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:17:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:17:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:19 INFO - https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:17:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:17:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:17:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/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 13:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/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 13:17:21 INFO - Downloaded 24312151 bytes. 13:17:21 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'] 13:17:21 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 13:17:22 INFO - Return code: 0 13:17:22 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 13:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:22 INFO - https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:17:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:17:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:17:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/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 13:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/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 13:17:23 INFO - Downloaded 24312151 bytes. 13:17:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:17:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:17:25 INFO - Return code: 0 13:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:25 INFO - https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:17:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:17:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:17:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/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 13:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/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 13:17:26 INFO - Downloaded 14403289 bytes. 13:17:26 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'] 13:17:26 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 13:17:26 INFO - Return code: 0 13:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:26 INFO - https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:17:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:17:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:17:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/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 13:17:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/afELaGZiRjiGuyO-CztgIw/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 13:17:27 INFO - Downloaded 60867603 bytes. 13:17:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:17:27 INFO - mkdir: /builds/slave/test/properties 13:17:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:17:27 INFO - Writing to file /builds/slave/test/properties/build_url 13:17:27 INFO - Contents: 13:17:27 INFO - build_url:https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:17:28 INFO - Running post-action listener: _resource_record_post_action 13:17:28 INFO - Running post-action listener: set_extra_try_arguments 13:17:28 INFO - [mozharness: 2016-07-24 20:17:28.452438Z] Finished download-and-extract step (success) 13:17:28 INFO - [mozharness: 2016-07-24 20:17:28.452670Z] Running populate-webroot step. 13:17:28 INFO - Running pre-action listener: _resource_record_pre_action 13:17:28 INFO - Running main action method: populate_webroot 13:17:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:17:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:17:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:17:28 INFO - '--tppagecycles', 13:17:28 INFO - '7'], 13:17:28 INFO - 'tests': ['tsvgm']}}, 13:17:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:17:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:17:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:17:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:17:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:28 INFO - 'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:28 INFO - 'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['damp', 'tps']}, 13:17:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:28 INFO - 'tests': ['damp', 'tps']}, 13:17:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['dromaeo_dom']}, 13:17:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:17:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['basic_compositor_video']}, 13:17:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:17:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['a11yr', 13:17:28 INFO - 'ts_paint', 13:17:28 INFO - 'tpaint', 13:17:28 INFO - 'sessionrestore', 13:17:28 INFO - 'sessionrestore_no_auto_restore', 13:17:28 INFO - 'tabpaint']}, 13:17:28 INFO - 'other-e10s': {'tests': ['a11yr', 13:17:28 INFO - 'ts_paint', 13:17:28 INFO - 'tpaint', 13:17:28 INFO - 'sessionrestore', 13:17:28 INFO - 'sessionrestore_no_auto_restore', 13:17:28 INFO - 'tabpaint']}, 13:17:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:17:28 INFO - 'ts_paint', 13:17:28 INFO - 'tpaint', 13:17:28 INFO - 'sessionrestore', 13:17:28 INFO - 'sessionrestore_no_auto_restore', 13:17:28 INFO - 'tabpaint']}, 13:17:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:17:28 INFO - 'ts_paint', 13:17:28 INFO - 'tpaint', 13:17:28 INFO - 'sessionrestore', 13:17:28 INFO - 'sessionrestore_no_auto_restore', 13:17:28 INFO - 'tabpaint']}, 13:17:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['a11yr', 13:17:28 INFO - 'ts_paint', 13:17:28 INFO - 'tpaint', 13:17:28 INFO - 'sessionrestore', 13:17:28 INFO - 'sessionrestore_no_auto_restore', 13:17:28 INFO - 'tabpaint']}, 13:17:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['a11yr', 13:17:28 INFO - 'ts_paint', 13:17:28 INFO - 'tpaint', 13:17:28 INFO - 'sessionrestore', 13:17:28 INFO - 'sessionrestore_no_auto_restore', 13:17:28 INFO - 'tabpaint']}, 13:17:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['tsvgx', 13:17:28 INFO - 'tsvgr_opacity', 13:17:28 INFO - 'tart', 13:17:28 INFO - 'tscrollx', 13:17:28 INFO - 'cart']}, 13:17:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:17:28 INFO - 'tsvgr_opacity', 13:17:28 INFO - 'tart', 13:17:28 INFO - 'tscrollx', 13:17:28 INFO - 'cart']}, 13:17:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:28 INFO - 'talos_options': ['--disable-e10s'], 13:17:28 INFO - 'tests': ['tp5o']}, 13:17:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:28 INFO - 'tests': ['tp5o']}, 13:17:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:28 INFO - 'talos_options': ['--disable-e10s', 13:17:28 INFO - '--xperf_path', 13:17:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:28 INFO - 'tests': ['tp5n']}, 13:17:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:28 INFO - 'talos_options': ['--xperf_path', 13:17:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:28 INFO - 'tests': ['tp5n']}}, 13:17:28 INFO - 'talos.zip': {'path': '', 13:17:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:17:28 INFO - Running post-action listener: _resource_record_post_action 13:17:28 INFO - [mozharness: 2016-07-24 20:17:28.468988Z] Finished populate-webroot step (success) 13:17:28 INFO - [mozharness: 2016-07-24 20:17:28.469077Z] Running create-virtualenv step. 13:17:28 INFO - Running pre-action listener: _resource_record_pre_action 13:17:28 INFO - Running main action method: create_virtualenv 13:17:28 INFO - Creating virtualenv /builds/slave/test/build/venv 13:17:28 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 13:17:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:17:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:17:28 INFO - Using real prefix '/usr' 13:17:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:17:29 INFO - Installing distribute.............................................................................................................................................................................................done. 13:17:31 INFO - Installing pip.................done. 13:17:31 INFO - Return code: 0 13:17:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:31 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 0x1a46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d053b0>, '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 0x1d062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d06740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', '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 13:17:31 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 13:17:31 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 13:17:31 INFO - Using env: {'DISPLAY': ':0', 13:17:31 INFO - 'HOME': '/home/cltbld', 13:17:31 INFO - 'LANG': 'en_US.UTF-8', 13:17:31 INFO - 'LANGUAGE': 'en_US:en', 13:17:31 INFO - 'LOGNAME': 'cltbld', 13:17:31 INFO - 'MAIL': '/var/mail/cltbld', 13:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:31 INFO - 'MOZ_NO_REMOTE': '1', 13:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:31 INFO - 'NO_EM_RESTART': '1', 13:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:31 INFO - 'PWD': '/builds/slave/test', 13:17:31 INFO - 'SHELL': '/bin/bash', 13:17:31 INFO - 'SHLVL': '1', 13:17:31 INFO - 'TERM': 'linux', 13:17:31 INFO - 'TMOUT': '86400', 13:17:31 INFO - 'USER': 'cltbld', 13:17:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', 13:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:31 INFO - '_': '/tools/buildbot/bin/python'} 13:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:31 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 13:17:31 INFO - Cleaning up... 13:17:31 INFO - Return code: 0 13:17:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:31 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 0x1a46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d053b0>, '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 0x1d062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d06740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', '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 13:17:31 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 13:17:31 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 13:17:31 INFO - Using env: {'DISPLAY': ':0', 13:17:31 INFO - 'HOME': '/home/cltbld', 13:17:31 INFO - 'LANG': 'en_US.UTF-8', 13:17:31 INFO - 'LANGUAGE': 'en_US:en', 13:17:31 INFO - 'LOGNAME': 'cltbld', 13:17:31 INFO - 'MAIL': '/var/mail/cltbld', 13:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:31 INFO - 'MOZ_NO_REMOTE': '1', 13:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:31 INFO - 'NO_EM_RESTART': '1', 13:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:31 INFO - 'PWD': '/builds/slave/test', 13:17:31 INFO - 'SHELL': '/bin/bash', 13:17:31 INFO - 'SHLVL': '1', 13:17:31 INFO - 'TERM': 'linux', 13:17:31 INFO - 'TMOUT': '86400', 13:17:31 INFO - 'USER': 'cltbld', 13:17:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', 13:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:31 INFO - '_': '/tools/buildbot/bin/python'} 13:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:31 INFO - Downloading/unpacking psutil>=3.1.1 13:17:31 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 13:17:31 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 13:17:31 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 13:17:31 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 13:17:31 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 13:17:31 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 13:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:17:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:33 INFO - Installing collected packages: psutil 13:17:33 INFO - Running setup.py install for psutil 13:17:34 INFO - building 'psutil._psutil_linux' extension 13:17:34 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 13:17:34 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 13:17:34 INFO - building 'psutil._psutil_posix' extension 13:17:34 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 13:17:34 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 13:17:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:34 INFO - Successfully installed psutil 13:17:34 INFO - Cleaning up... 13:17:34 INFO - Return code: 0 13:17:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d053b0>, '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 0x1d062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d06740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', '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 13:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:17:34 INFO - Using env: {'DISPLAY': ':0', 13:17:34 INFO - 'HOME': '/home/cltbld', 13:17:34 INFO - 'LANG': 'en_US.UTF-8', 13:17:34 INFO - 'LANGUAGE': 'en_US:en', 13:17:34 INFO - 'LOGNAME': 'cltbld', 13:17:34 INFO - 'MAIL': '/var/mail/cltbld', 13:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:34 INFO - 'MOZ_NO_REMOTE': '1', 13:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:34 INFO - 'NO_EM_RESTART': '1', 13:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:34 INFO - 'PWD': '/builds/slave/test', 13:17:34 INFO - 'SHELL': '/bin/bash', 13:17:34 INFO - 'SHLVL': '1', 13:17:34 INFO - 'TERM': 'linux', 13:17:34 INFO - 'TMOUT': '86400', 13:17:34 INFO - 'USER': 'cltbld', 13:17:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', 13:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:34 INFO - '_': '/tools/buildbot/bin/python'} 13:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:17:36 INFO - Installing collected packages: mozsystemmonitor 13:17:36 INFO - Running setup.py install for mozsystemmonitor 13:17:36 INFO - Successfully installed mozsystemmonitor 13:17:36 INFO - Cleaning up... 13:17:37 INFO - Return code: 0 13:17:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d053b0>, '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 0x1d062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d06740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', '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 13:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:17:37 INFO - Using env: {'DISPLAY': ':0', 13:17:37 INFO - 'HOME': '/home/cltbld', 13:17:37 INFO - 'LANG': 'en_US.UTF-8', 13:17:37 INFO - 'LANGUAGE': 'en_US:en', 13:17:37 INFO - 'LOGNAME': 'cltbld', 13:17:37 INFO - 'MAIL': '/var/mail/cltbld', 13:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:37 INFO - 'MOZ_NO_REMOTE': '1', 13:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:37 INFO - 'NO_EM_RESTART': '1', 13:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:37 INFO - 'PWD': '/builds/slave/test', 13:17:37 INFO - 'SHELL': '/bin/bash', 13:17:37 INFO - 'SHLVL': '1', 13:17:37 INFO - 'TERM': 'linux', 13:17:37 INFO - 'TMOUT': '86400', 13:17:37 INFO - 'USER': 'cltbld', 13:17:37 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', 13:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:37 INFO - '_': '/tools/buildbot/bin/python'} 13:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:37 INFO - Downloading/unpacking jsonschema==2.5.1 13:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:17:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:40 INFO - Downloading functools32-3.2.3-2.tar.gz 13:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:17:40 INFO - warning: no files found matching '*.txt' 13:17:40 INFO - no previously-included directories found matching 'build' 13:17:40 INFO - no previously-included directories found matching 'dist' 13:17:40 INFO - no previously-included directories found matching '.git*' 13:17:40 INFO - Installing collected packages: jsonschema, functools32 13:17:40 INFO - Running setup.py install for functools32 13:17:40 INFO - warning: no files found matching '*.txt' 13:17:40 INFO - no previously-included directories found matching 'build' 13:17:40 INFO - no previously-included directories found matching 'dist' 13:17:40 INFO - no previously-included directories found matching '.git*' 13:17:40 INFO - Successfully installed jsonschema functools32 13:17:40 INFO - Cleaning up... 13:17:40 INFO - Return code: 0 13:17:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d053b0>, '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 0x1d062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d06740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', '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 13:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:17:40 INFO - Using env: {'DISPLAY': ':0', 13:17:40 INFO - 'HOME': '/home/cltbld', 13:17:40 INFO - 'LANG': 'en_US.UTF-8', 13:17:40 INFO - 'LANGUAGE': 'en_US:en', 13:17:40 INFO - 'LOGNAME': 'cltbld', 13:17:40 INFO - 'MAIL': '/var/mail/cltbld', 13:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:40 INFO - 'MOZ_NO_REMOTE': '1', 13:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:40 INFO - 'NO_EM_RESTART': '1', 13:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:40 INFO - 'PWD': '/builds/slave/test', 13:17:40 INFO - 'SHELL': '/bin/bash', 13:17:40 INFO - 'SHLVL': '1', 13:17:40 INFO - 'TERM': 'linux', 13:17:40 INFO - 'TMOUT': '86400', 13:17:40 INFO - 'USER': 'cltbld', 13:17:40 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', 13:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:40 INFO - '_': '/tools/buildbot/bin/python'} 13:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:40 INFO - Downloading/unpacking blobuploader==1.2.4 13:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:42 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:43 INFO - Downloading docopt-0.6.1.tar.gz 13:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:43 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:43 INFO - Running setup.py install for blobuploader 13:17:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:43 INFO - Running setup.py install for requests 13:17:43 INFO - Running setup.py install for docopt 13:17:43 INFO - Successfully installed blobuploader requests docopt 13:17:43 INFO - Cleaning up... 13:17:43 INFO - Return code: 0 13:17:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 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 0x1a46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d053b0>, '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 0x1d062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d06740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', '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 13:17:43 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 13:17:43 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 13:17:43 INFO - Using env: {'DISPLAY': ':0', 13:17:43 INFO - 'HOME': '/home/cltbld', 13:17:43 INFO - 'LANG': 'en_US.UTF-8', 13:17:43 INFO - 'LANGUAGE': 'en_US:en', 13:17:43 INFO - 'LOGNAME': 'cltbld', 13:17:43 INFO - 'MAIL': '/var/mail/cltbld', 13:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:43 INFO - 'MOZ_NO_REMOTE': '1', 13:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:43 INFO - 'NO_EM_RESTART': '1', 13:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:43 INFO - 'PWD': '/builds/slave/test', 13:17:43 INFO - 'SHELL': '/bin/bash', 13:17:43 INFO - 'SHLVL': '1', 13:17:43 INFO - 'TERM': 'linux', 13:17:43 INFO - 'TMOUT': '86400', 13:17:43 INFO - 'USER': 'cltbld', 13:17:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', 13:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:43 INFO - '_': '/tools/buildbot/bin/python'} 13:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:44 INFO - Running setup.py (path:/tmp/pip-NeV7SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:44 INFO - Running setup.py (path:/tmp/pip-lIS7Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:44 INFO - Running setup.py (path:/tmp/pip-RkXtHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:44 INFO - Running setup.py (path:/tmp/pip-YRFwY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:44 INFO - Running setup.py (path:/tmp/pip-AbOAPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:44 INFO - Running setup.py (path:/tmp/pip-EHyR5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:44 INFO - Running setup.py (path:/tmp/pip-wKKo5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:44 INFO - Running setup.py (path:/tmp/pip-xCxzmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:44 INFO - Running setup.py (path:/tmp/pip-yKKv9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:44 INFO - Running setup.py (path:/tmp/pip-puj3Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:44 INFO - Running setup.py (path:/tmp/pip-tIF07O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:44 INFO - Running setup.py (path:/tmp/pip-ur3Xiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:44 INFO - Running setup.py (path:/tmp/pip-PRjm4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:44 INFO - Running setup.py (path:/tmp/pip-gYz0wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:45 INFO - Running setup.py (path:/tmp/pip-M4f0ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:45 INFO - Running setup.py (path:/tmp/pip-jj92rV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:45 INFO - Running setup.py (path:/tmp/pip-YKq6WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:45 INFO - Running setup.py install for manifestparser 13:17:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:45 INFO - Running setup.py install for mozcrash 13:17:45 INFO - Running setup.py install for mozdebug 13:17:45 INFO - Running setup.py install for mozdevice 13:17:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:45 INFO - Running setup.py install for mozfile 13:17:45 INFO - Running setup.py install for mozhttpd 13:17:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:45 INFO - Running setup.py install for mozinfo 13:17:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:45 INFO - Running setup.py install for mozInstall 13:17:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozleak 13:17:46 INFO - Running setup.py install for mozlog 13:17:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for moznetwork 13:17:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozprocess 13:17:46 INFO - Running setup.py install for mozprofile 13:17:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozrunner 13:17:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozscreenshot 13:17:46 INFO - Running setup.py install for moztest 13:17:46 INFO - Running setup.py install for mozversion 13:17:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:47 INFO - Cleaning up... 13:17:47 INFO - Return code: 0 13:17:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:47 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 0x1a46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d053b0>, '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 0x1d062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d06740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', '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 13:17:47 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 13:17:47 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 13:17:47 INFO - Using env: {'DISPLAY': ':0', 13:17:47 INFO - 'HOME': '/home/cltbld', 13:17:47 INFO - 'LANG': 'en_US.UTF-8', 13:17:47 INFO - 'LANGUAGE': 'en_US:en', 13:17:47 INFO - 'LOGNAME': 'cltbld', 13:17:47 INFO - 'MAIL': '/var/mail/cltbld', 13:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:47 INFO - 'MOZ_NO_REMOTE': '1', 13:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:47 INFO - 'NO_EM_RESTART': '1', 13:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:47 INFO - 'PWD': '/builds/slave/test', 13:17:47 INFO - 'SHELL': '/bin/bash', 13:17:47 INFO - 'SHLVL': '1', 13:17:47 INFO - 'TERM': 'linux', 13:17:47 INFO - 'TMOUT': '86400', 13:17:47 INFO - 'USER': 'cltbld', 13:17:47 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', 13:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:47 INFO - '_': '/tools/buildbot/bin/python'} 13:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:47 INFO - Running setup.py (path:/tmp/pip-NaOtU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:47 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)) 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:47 INFO - Running setup.py (path:/tmp/pip-9LvYrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:47 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)) 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:47 INFO - Running setup.py (path:/tmp/pip-Y_sTto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:47 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)) 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:47 INFO - Running setup.py (path:/tmp/pip-HLKVnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:47 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)) 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:47 INFO - Running setup.py (path:/tmp/pip-VnteZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:47 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)) 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:47 INFO - Running setup.py (path:/tmp/pip-_4ic_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:47 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)) 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:47 INFO - Running setup.py (path:/tmp/pip-zcia0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:47 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)) 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:47 INFO - Running setup.py (path:/tmp/pip-M8JCXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:47 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)) 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:47 INFO - Running setup.py (path:/tmp/pip-1900tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:47 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)) 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:47 INFO - Running setup.py (path:/tmp/pip-eLnHGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:47 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:48 INFO - Running setup.py (path:/tmp/pip-jzSRuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:48 INFO - Running setup.py (path:/tmp/pip-BCX8_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:48 INFO - Running setup.py (path:/tmp/pip-V90mgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:48 INFO - Running setup.py (path:/tmp/pip-ausjPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:48 INFO - Running setup.py (path:/tmp/pip-3PK6xL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:48 INFO - Running setup.py (path:/tmp/pip-ZRuXEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:48 INFO - Running setup.py (path:/tmp/pip-E2e03O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:48 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)) 13:17:48 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)) 13:17:48 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)) 13:17:48 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)) 13:17:48 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)) 13:17:48 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)) 13:17:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:50 INFO - Downloading blessings-1.6.tar.gz 13:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:50 INFO - Installing collected packages: blessings 13:17:50 INFO - Running setup.py install for blessings 13:17:50 INFO - Successfully installed blessings 13:17:50 INFO - Cleaning up... 13:17:50 INFO - Return code: 0 13:17:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:50 INFO - Reading from file tmpfile_stdout 13:17:50 INFO - Current package versions: 13:17:50 INFO - argparse == 1.2.1 13:17:50 INFO - blessings == 1.6 13:17:50 INFO - blobuploader == 1.2.4 13:17:50 INFO - docopt == 0.6.1 13:17:50 INFO - functools32 == 3.2.3-2 13:17:50 INFO - jsonschema == 2.5.1 13:17:50 INFO - manifestparser == 1.1 13:17:50 INFO - mozInstall == 1.12 13:17:50 INFO - mozcrash == 0.17 13:17:50 INFO - mozdebug == 0.1 13:17:50 INFO - mozdevice == 0.48 13:17:50 INFO - mozfile == 1.2 13:17:50 INFO - mozhttpd == 0.7 13:17:50 INFO - mozinfo == 0.9 13:17:50 INFO - mozleak == 0.1 13:17:50 INFO - mozlog == 3.3 13:17:50 INFO - moznetwork == 0.27 13:17:50 INFO - mozprocess == 0.23 13:17:50 INFO - mozprofile == 0.28 13:17:50 INFO - mozrunner == 6.12 13:17:50 INFO - mozscreenshot == 0.1 13:17:50 INFO - mozsystemmonitor == 0.3 13:17:50 INFO - moztest == 0.7 13:17:50 INFO - mozversion == 1.4 13:17:50 INFO - psutil == 3.1.1 13:17:50 INFO - requests == 1.2.3 13:17:50 INFO - wsgiref == 0.1.2 13:17:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:50 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 0x1a46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d053b0>, '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 0x1d062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d06740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', '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 13:17:50 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 13:17:50 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 13:17:50 INFO - Using env: {'DISPLAY': ':0', 13:17:50 INFO - 'HOME': '/home/cltbld', 13:17:50 INFO - 'LANG': 'en_US.UTF-8', 13:17:50 INFO - 'LANGUAGE': 'en_US:en', 13:17:50 INFO - 'LOGNAME': 'cltbld', 13:17:50 INFO - 'MAIL': '/var/mail/cltbld', 13:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:50 INFO - 'MOZ_NO_REMOTE': '1', 13:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:50 INFO - 'NO_EM_RESTART': '1', 13:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:50 INFO - 'PWD': '/builds/slave/test', 13:17:50 INFO - 'SHELL': '/bin/bash', 13:17:50 INFO - 'SHLVL': '1', 13:17:50 INFO - 'TERM': 'linux', 13:17:50 INFO - 'TMOUT': '86400', 13:17:50 INFO - 'USER': 'cltbld', 13:17:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', 13:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:50 INFO - '_': '/tools/buildbot/bin/python'} 13:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 INFO - Cleaning up... 13:17:51 INFO - Return code: 0 13:17:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17:51 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')]} 13:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:51 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')]} 13:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:51 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 0x1a46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d053b0>, '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 0x1d062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d06740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', '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 13:17:51 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 13:17:51 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 13:17:51 INFO - Using env: {'DISPLAY': ':0', 13:17:51 INFO - 'HOME': '/home/cltbld', 13:17:51 INFO - 'LANG': 'en_US.UTF-8', 13:17:51 INFO - 'LANGUAGE': 'en_US:en', 13:17:51 INFO - 'LOGNAME': 'cltbld', 13:17:51 INFO - 'MAIL': '/var/mail/cltbld', 13:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:51 INFO - 'MOZ_NO_REMOTE': '1', 13:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:51 INFO - 'NO_EM_RESTART': '1', 13:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:51 INFO - 'PWD': '/builds/slave/test', 13:17:51 INFO - 'SHELL': '/bin/bash', 13:17:51 INFO - 'SHLVL': '1', 13:17:51 INFO - 'TERM': 'linux', 13:17:51 INFO - 'TMOUT': '86400', 13:17:51 INFO - 'USER': 'cltbld', 13:17:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', 13:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:51 INFO - '_': '/tools/buildbot/bin/python'} 13:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:17:51 INFO - Cleaning up... 13:17:51 INFO - Return code: 0 13:17:51 INFO - Running post-action listener: _resource_record_post_action 13:17:51 INFO - Running post-action listener: _start_resource_monitoring 13:17:51 INFO - Starting resource monitoring. 13:17:51 INFO - [mozharness: 2016-07-24 20:17:51.346234Z] Finished create-virtualenv step (success) 13:17:51 INFO - [mozharness: 2016-07-24 20:17:51.346719Z] Running install step. 13:17:51 INFO - Running pre-action listener: _resource_record_pre_action 13:17:51 INFO - Running main action method: install 13:17:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:51 INFO - Reading from file tmpfile_stdout 13:17:51 INFO - Detecting whether we're running mozinstall >=1.0... 13:17:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:17:51 INFO - Reading from file tmpfile_stdout 13:17:51 INFO - Output received: 13:17:51 INFO - Usage: mozinstall [options] installer 13:17:51 INFO - Options: 13:17:51 INFO - -h, --help show this help message and exit 13:17:51 INFO - -d DEST, --destination=DEST 13:17:51 INFO - Directory to install application into. [default: 13:17:51 INFO - "/builds/slave/test"] 13:17:51 INFO - --app=APP Application being installed. [default: firefox] 13:17:51 INFO - mkdir: /builds/slave/test/build/application 13:17:51 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'] 13:17:51 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 13:18:08 INFO - Reading from file tmpfile_stdout 13:18:08 INFO - Output received: 13:18:08 INFO - /builds/slave/test/build/application/firefox/firefox 13:18:08 INFO - Running post-action listener: _resource_record_post_action 13:18:08 INFO - [mozharness: 2016-07-24 20:18:08.845993Z] Finished install step (success) 13:18:08 INFO - [mozharness: 2016-07-24 20:18:08.846269Z] Running run-tests step. 13:18:08 INFO - Running pre-action listener: _resource_record_pre_action 13:18:08 INFO - Running main action method: run_tests 13:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:08 INFO - Python 2.7.3 13:18:08 INFO - Return code: 0 13:18:08 INFO - grabbing minidump binary from tooltool 13: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')]} 13:18:08 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 0x1d053b0>, '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 0x1d062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d06740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:08 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 13:18:08 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 13:18:08 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 13:18:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:08 INFO - Return code: 0 13:18:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:18:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:18:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:08 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:18:08 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:18:08 INFO - Using env: {'DISPLAY': ':0', 13:18:08 INFO - 'HOME': '/home/cltbld', 13:18:08 INFO - 'LANG': 'en_US.UTF-8', 13:18:08 INFO - 'LANGUAGE': 'en_US:en', 13:18:08 INFO - 'LOGNAME': 'cltbld', 13:18:08 INFO - 'MAIL': '/var/mail/cltbld', 13:18:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:08 INFO - 'MOZ_NO_REMOTE': '1', 13:18:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:08 INFO - 'NO_EM_RESTART': '1', 13:18:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:08 INFO - 'PWD': '/builds/slave/test', 13:18:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:08 INFO - 'SHELL': '/bin/bash', 13:18:08 INFO - 'SHLVL': '1', 13:18:08 INFO - 'TERM': 'linux', 13:18:08 INFO - 'TMOUT': '86400', 13:18:08 INFO - 'USER': 'cltbld', 13:18:08 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123', 13:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:08 INFO - '_': '/tools/buildbot/bin/python'} 13:18:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:18:09 INFO - mozversion application_buildid: 20160724103056 13:18:09 INFO - mozversion application_changeset: 07322a610cf811ce8b9a6b76f8b731af1f30d9d7 13:18:09 INFO - mozversion application_display_name: Nightly 13:18:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:09 INFO - mozversion application_name: Firefox 13:18:09 INFO - mozversion application_remotingname: firefox 13:18:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:18:09 INFO - mozversion application_vendor: Mozilla 13:18:09 INFO - mozversion application_version: 50.0a1 13:18:09 INFO - mozversion platform_buildid: 20160724103056 13:18:09 INFO - mozversion platform_changeset: 07322a610cf811ce8b9a6b76f8b731af1f30d9d7 13:18:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:18:09 INFO - mozversion platform_version: 50.0a1 13:18:09 INFO - using testdate: 1469391489 13:18:09 INFO - actual date: 1469391489 13:18:09 INFO - starting webserver on 'localhost:59950' 13:18:09 INFO - SUITE-START | Running 2 tests 13:18:09 INFO - TEST-START | dromaeo_css 13:18:09 INFO - operating with platform_type : linux_ 13:18:09 INFO - Initialising browser for dromaeo_css test... 13:18:09 INFO - TEST-INFO | started process 4923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzvtbqe/profile http://localhost:59950/getInfo.html) 13:18:12 INFO - PROCESS | 4923 | JavaScript error: , line 0: uncaught exception: undefined 13:18:13 INFO - PROCESS | 4923 | __metrics Screen width/height:1600/1200 13:18:13 INFO - PROCESS | 4923 | colorDepth:24 13:18:13 INFO - PROCESS | 4923 | Browser inner width/height: 1024/697 13:18:13 INFO - PROCESS | 4923 | __metrics 13:18:14 INFO - PROCESS | 4923 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:18:14 INFO - PROCESS | 4923 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:18:15 INFO - TEST-INFO | 4923: exit 0 13:18:15 INFO - Browser initialized. 13:18:15 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:15 INFO - TEST-INFO | started process 5007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzvtbqe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:27 INFO - PROCESS | 5007 | RSS: Main: 158117888 13:18:27 INFO - PROCESS | 5007 | 13:19:18 INFO - PROCESS | 5007 | 1469391558644 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] 13:21:26 INFO - PROCESS | 5007 | Cycle 1(1): loaded http://localhost:59950/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59950/tests/dromaeo/cssquery-ext.html) 13:21:27 INFO - PROCESS | 5007 | RSS: Main: 281591808 13:21:27 INFO - PROCESS | 5007 | 13:24:29 INFO - PROCESS | 5007 | Cycle 1(1): loaded http://localhost:59950/tests/dromaeo/cssquery-ext.html (next: http://localhost:59950/tests/dromaeo/cssquery-jquery.html) 13:24:30 INFO - PROCESS | 5007 | RSS: Main: 242933760 13:24:30 INFO - PROCESS | 5007 | 13:27:32 INFO - PROCESS | 5007 | Cycle 1(1): loaded http://localhost:59950/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59950/tests/dromaeo/cssquery-mootools.html) 13:27:33 INFO - PROCESS | 5007 | RSS: Main: 223174656 13:27:33 INFO - PROCESS | 5007 | 13:30:35 INFO - PROCESS | 5007 | Cycle 1(1): loaded http://localhost:59950/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59950/tests/dromaeo/cssquery-prototype.html) 13:30:35 INFO - PROCESS | 5007 | RSS: Main: 222633984 13:30:35 INFO - PROCESS | 5007 | 13:33:38 INFO - PROCESS | 5007 | Cycle 1(1): loaded http://localhost:59950/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59950/tests/dromaeo/cssquery-yui.html) 13:33:38 INFO - PROCESS | 5007 | RSS: Main: 183558144 13:33:38 INFO - PROCESS | 5007 | 13:36:41 INFO - PROCESS | 5007 | Cycle 1(1): loaded http://localhost:59950/tests/dromaeo/cssquery-yui.html (next: http://localhost:59950/tests/dromaeo/cssquery-dojo.html) 13:36:41 INFO - PROCESS | 5007 | RSS: Main: 282091520 13:36:41 INFO - PROCESS | 5007 | 13:36:41 INFO - PROCESS | 5007 | __start_tp_report 13:36:41 INFO - PROCESS | 5007 | _x_x_mozilla_page_load 13:36:41 INFO - PROCESS | 5007 | _x_x_mozilla_page_load_details 13:36:41 INFO - PROCESS | 5007 | |i|pagename|runs| 13:36:41 INFO - PROCESS | 5007 | |0;dojo.html;3028.636563612367;3028.909132726018;3064.3718037802255;3065.7087576680206;3073.4314151881904;5140.8971820563565;5202.245674377223;5208.557272631826;5256.92114618281;5347.251384806125;5320.095583750762;5330.413654498012;5389.83830485086;5428.972855135718;5487.451254874521;4830.73430961297;4833.516648335165;4867.610591152699;4876.902461950776;4994.525520075587;4938.678985865925;4964.180910149821;4974.676646018015;4976.228684553882;4977.55202031817;4767.928481072787;4776.880577985544;4812.542808433193;4922.606191504671;4933.358663373757;4750.976245118787;4758.262469317261;4829.106615276185;4831.710097394132;4884.951150488485;4759.524047595248;4818.975905120487;4833.927491087637;4837.758112094381;4863.8784030399165;5321.840344789663;5333.546648534879;5364.195370694427;5379.1662292344745;5388.488093631099;5433.049216387156;5548.805791797267;5581.386047534768;5585.329760428734;5677.120046392815;5685.914711279334;5715.599908006441;5716.456936591058;5723.399043100498;5723.685197314146;5293.444188360205;5321.015612111772;5326.440723723992;5331;5331.280277162611;5637.210790489335;5684.573656975661;5689.829305120853;5760.769569217185;5763.452472015152;5538.695371754592;5551.417101204396;5584.497395234448;5593.161025846074;5659.320881494247;5688.63023903445;5730.455606717355;5736.741846616912;5741.311042674823;5745.626534275259;5579.2746942897975;5671.716414179275;5677.716114194356;5677.772889084473;5680.517156041783;5387.191921211771;5623.8875222496135;5684.147377893349;5686.3744988051285;5758.193852860602;4340.348947657877;4342.370356298319;4346.282863327516;4359.04101097758;4386.517483076859;3860.2472517858746;3871.612838716162;3881.6700580450415;3925.685945124383;3939.212157568498;5183.170692689152;5198.974005130026;5239.659422137549;5259.368875734936;5300.44345343741;5646.040173170571;5662.207290979266;5669.829905102853;5698.943010569841;5705.315362156568;5307.867303317448;5311.044012077786;5315.255864179018;5318.627696061239;5322.414534401213;4793.592544633675;4864.902701945941;4883.780229889663;4896.143174944442;4934.605231581465;5821.359650438533;5886.05823068307;5895.498882595028;5930.140129681172;5931.881362372728;5676.829695109153;5676.971615141898;5680.062789639828;5700.771969121189;5707.857303567444;5500.4224556420995;5676.063449530946;5800;5856.0630299151935;5868.882622347614;5520.889582208253;5567.66594004361;5587.77648894056;5608.9158662619275;5619.8595035124445;5639.830805075854;5672.432756724294;5682.090865461506;5682.261306030189;5690.374058853606;5321.920171197513;5417.485338892799;5550.250716153268;5551.08407112838;5552.416996215339;5466.34403871538;5512.3660779010925;5513;5555.638883472561;5558.833235002957;5404.243405923095;5437.673739575638;5440.156775699773;5444.754986025559;5447.1829225616475;5348.5186333230195;5526.253955716088;5571.331440227199;5581.776728930798;5584;5434.864128396822;5479.863003424946;5520.420355862737;5546.889062218814;5550.361708403424 13:36:41 INFO - PROCESS | 5007 | |1;ext.html;587.7061469265367;611.709438016942;615.3047056825789;630.4105661206773;637.2798737426707;43002.784986075065;44155;44170.77914610422;44370.33444498331;47503;46116;46523.30215046777;46524.302135467995;46537;46570;8953.641854325819;9069.183773460387;9076.183143517082;9076.41003334781;9080.909190908105;8955.462672239686;9068.093190680946;9068.36521443496;9070.183683468487;9070.546472676373;9095.408798428081;9139.268858491338;9142.542872856364;9145.131212534798;9153.496557689325;9044.050374710627;9053.637854485813;9082.909170908273;9098.272138228926;9106.726798196065;8987.281017518582;9006.054364291786;9034.503102329369;9046.411983221069;9061.546922653906;41375.27622513988;41455.37816932749;41641;41697.37453938193;41760;3445.63820798815;3565.6969157621634;3573.3032058748554;3593.586737525192;3686.870959516404;32852.507212391836;32984.83507582471;33271.3345733084;33317.33365332704;33374.6662533374;4415.51429342772;4494.37078808967;4511.323301504768;4599.816007359702;4617.353570500132;376311;378770;379795;380257.0987145074;380921;52309.47690523122;52513.7374313126;52545.47454525406;52651;52653;61403.38596614066;61427.692861535405;61484.69257653683;61487.692561536904;61518.69240653768;16335;16444.506664800076;16479.423220187477;16489.83510164883;16505.752413713803;12865.356732163355;12913.354332283348;12915.612531624067;12921.741565168832;12924.483020679256;14921.477748278758;16139.919300403422;16192.595185120466;16294.429694960856;16687.415940442028;5943.940560594425;5998.310194327621;6066.332703402622;6071.089336599457;6113;985.6205360935948;1033.9844902326472;1053.5733028123468;1063.106990128296;1068.9518971646294;32562;33335.333293334;33551.49672754911;33665.831670841486;33979.830100849336;941.8681384606024;1083.3316692293936;1086.5979587552656;1088.8475613414128;1161.4773351991637;15906.840931590767;16374.918125409296;16457.670846583;16489.6702065958;16671.16644167811;540987;543650;544821;545458;571941;58258.12612810811;58417.70791146017;58433.70783146057;58479;58515;1249.419020155632;1343.1538130977617;1354.6071639224515;1369.4932874836375;1375.69734658375;31624.209394765316;32602.51096233606;33445.665543345225;33607.66392336143;34078;50422;51030.48969510257;51089;51110.74444627753;51117.74441127919;393112;393368;394602;394796;396329;27318.726812731617;28478.43043139167;28485.287867802643;29269.85365073161;29525;48531.757341213066;48535.75732121317;48842.5115748838;48895.75552122216;50355.49644503508;41386.1722765537;41388;42230.366544501245;43431.34852977144;43557;41867.7906610465;42154.789226053676;42569.57430425656;43447.78276108599;43790.56209437865;41090.58909410868;42273.365899512144;42512.14975700407;42667.51991040896;42792.572074280106;35366;37474.16030325206;37985;38359.42460863145;38904.61095389123;28315.575266371434;28375.29061773472;28707.71292287134;28722.856385717936;28873.85563072171 13:36:41 INFO - PROCESS | 5007 | |2;jquery.html;367.71685801932495;373.9252149570085;393.88971088095343;396.89283893348795;416.14482238998863;17098.91450542747;19128.904355478222;19255.326063587778;19401;19964.40106796795;14994.550163495085;15006.174660393674;15134.24328783562;15244.314005869735;18283.634327313444;5658.745356458949;5855.297364316267;5863.618864773797;5865.8826823463505;5871.765129394819;5517.475839795213;5696.746715722535;5723.198752174699;5726.3987281335485;5732.48407643312;5718.857028574277;5723.4848863602265;5727.914081288784;5728.341240757304;5731.398203188668;5503.449655034505;5727.799527016556;5765.711714414305;5775.249217601727;5781.306243250816;5121.2318152277085;5135.204043373283;5142.460041695643;5171.922421163686;5177.792888284464;21715.13139474435;23290.767092329028;23345.766542334528;23362.415939601477;23630.881845590833;2169.804717575426;2266.444721043355;2328.4760928791056;2434.415740222352;2823.6611606607134;9792.21662267017;9823.459709715962;10209.89790102097;10502.9474852626;10711.625093121782;1863.6738570750065;1908.5801123752751;1948.0844003318418;1949.083930552638;2008;78042;84263.5786821068;86198;87224;88228;10828.78342433147;11005.669829905115;11070.28043177191;11116.777664446667;11306.660800176009;15415.61460963485;15438.5368438947;15462.768058479132;15470.845291547166;15526.913116081992;8128.268455839003;8236.094029656733;8375.874361884577;8396.160383961555;8437.704680336281;7778.455508114378;7810.873961789929;7811.336036436853;8060.959695201486;8217.34261259098;4671.7430541320555;4719.5752382285755;4763.833265835679;4854.80580776765;4874.975625121922;1884.7644044494439;2017.7578690556934;2022.1911235505622;2026.533897203622;2029.7462817147857;884.9070847560913;961.2790407194605;1017.4759998600726;1026.2046913641987;1038.190211634926;18635.627287454176;19103.426897193105;19507.219711211677;19549.706754398696;19791.505212369517;953.77109493721;972.179335212607;994.4629899854142;999.6201443451442;1002.5387673262125;10382.896171038345;10663.573457061631;10946.343219406861;11027.17296202772;11028.44857757109;521495;525128;530454;533930;537776;71162;73475;94070;96063.51968240114;98942;852.2117041736369;888.626776753765;889.4352086425038;892.2148509311764;892.8839250897472;17754.20106095203;17904.194311256284;18361.449156525327;18365.54086147857;18431.984156455008;32140.517892232103;34477.31045379129;45947;46269.53730462652;47304.7634761824;63706.681466592374;63906;64190.35809642031;64355;64617.67691161514;7719.498232614862;8257.95871020641;8609.784755381166;8676.219140277406;8678.739637810622;7561.130469996021;9917;11184;12480.313582753035;13338.666533336356;10279.537420815932;10674.985876341736;10989.835152472559;11476.483558239732;11544.422778860855;10433.895661043292;10989.340639561651;11209.607663731731;11465.14011449128;11508.654740357802;11590.71023224426;11638.592649257236;11710.4730287139;11739.06087513014;11780.646580602595;8468.703595374132;8605.451018816422;8669.30645548342;8714.825703486022;8854.468731876108;8676.175763302475;10365.429901355497;11063.391513466837;11173.49719262619;11420 13:36:41 INFO - PROCESS | 5007 | |3;mootools.html;1435.33974371789;1493.2011373914954;1586.4606033948455;1659.2450435052053;1726.15418444962;8489.108643592426;8952.462852228871;8972.641094356219;9001.684941027057;9009.90990090098;7567.735129270477;8369.121242269566;8619.181177788116;8658.307335413168;8749.606267717953;2309.7343805462333;2339.94150146246;2340.6137987232087;2340.707411573553;2342.508073304608;2295.988520057406;2302.2747834432103;2385.3917251100943;2391.5934291170543;2393.2939782764124;2346.6480027995767;2349.283468542094;2358.3043002314357;2376.940576485593;2390.497995420964;2232.218723446797;2246.067881829039;2253.752087270391;2257.909683612662;2313.6066868632206;2287.2795069553035;2290.6678531612824;2294.4837411582425;2296.712910886139;2298.8275879308953;8918.643254269822;9051.41165824226;9067.093290670946;9067.410618309788;9075.54622268884;5153.175491921312;5321.148616221425;5321.2284218788445;5325.707086110262;5328.680279183222;3132.8120312781307;3158.178873492908;3323.567936168307;3324.268660894599;3326.7172290355347;1097.5335482420019;1112.7663190729875;1133.9036181924546;1150.7986102432124;1162.9185956983015;12472.251664900135;12473.563425280072;12558.623241302776;12571.93714031424;12578.056645751514;4338.76136812472;4453.198424283595;4549.340345649863;4588.151192029485;4589.58693717567;10472.37165770041;10480.423576703355;10498.317609355367;10506.369617822955;10509.579616815394;5257.947420525822;5266.183741520071;5274.103402421598;5279.947200528022;5280.313559237351;4322.7190232634775;4745.335653008581;4811.879703007453;4820.276958456189;4845.5881250093435;3816.6183381661613;3954.7824869632445;3959;3965.7422267552515;4034.536028356718;1249.1693024139026;1258.1193164784688;1273.6433798536425;1288.8711128887037;1321.6960099177052;910.5265262063822;933.3513208320152;947.507296205969;961.927855410847;996.725900377402;5637.3235211774845;5712.0860662293835;5903.881922361528;5931.377205393372;6101.511879049665;447.95296493868324;449.138321656731;450.2818005281571;458.5368777534714;460.452062046164;3949.664278536299;4068.7355321903983;4077;4080.6531444827524;4133.594577843548;10325.63860264887;11090;11123.221374503868;11202.607908723156;11232.943835280772;10878.673639790819;10935.234533582572;11001.61494347694;11007.669769906915;11035.117190624731;8206.302464290482;8322.29260512851;8343.290820280345;8354.45696029756;8356;5695.800646977336;5697.54419646419;5764.913526297025;5812.854678633068;5913.645181289136;10090.88091500793;10119.392836429837;10161.085502304531;10164.33931794431;10299.073083422529;10199.643012494527;10513.89486105129;10628.096611788085;10653.455248988697;10761.30051546647;7071.611061391673;7634.198409166957;7811.218878112143;7910.129885712452;7970.083440404428;8334.874976875473;8452.32381409498;8528.573571321533;8531.53076580794;8545;7547.018887544584;7644.273793989562;7846;7921.32668723142;7958.602069896367;7458.254174582498;7569.394448444222;7582.279683430065;7597.88603170964;7696.8460630788195;6334.208223972004;6440.516961227833;6441.1626488556185;6445.12990746262;6447.2263328400895;4815.15734746411;4990.80036798524;5015.896502769385;5187.403448603459;5211.661242019257;5062.443131255633;5193.221016847503;5236.738163091906;5270.657407268515;5276.918231762403 13:36:41 INFO - PROCESS | 5007 | |4;prototype.html;328.72715646013813;332.9976769922533;335.9428897087495;337.78213052581077;345.55078398082486;5345.839624811257;5372.059889519333;5383.246345511622;5385.407605163429;5406.729663516819;5069.377799104279;5158.380994280682;5164.793408263675;5205.479452054793;5378.946210537893;4080.0411903202726;4091.5703851095654;4155.792210389483;4189.937150942738;4215.732807074511;4133.318002529579;4139.544650088488;4175.269327867626;4190.9580904191025;4244.511881133662;4073.674106071522;4139.482564679415;4176.0603864130635;4191.664666826662;4204.11713540157;4132.318167502359;4159.9792001040105;4175.62419382257;4177.624013838754;4185.393117997888;3697.2975134724584;3712.109093817491;3714.888553343404;3715.981420092909;3742.35336451963;4967.677100988424;5161.845144645667;5163.845084647466;5173.870653233662;5189.896202075937;4727.692699974525;4743.407074115701;4743.430788305425;4753.691010084333;4763.476017638057;5441.095616534221;5459;5485.341758988907;5496.587755918322;5505.21986396867;3963.286608410485;4040.1313717550574;4041.7372870763306;4048.412980117896;4090.141070375225;5669.801556945487;5678.5803549112725;5704.974733969464;5736.139579063132;5749.568782341341;4138.151678905817;4145.253854306254;4165.812538435717;4181.954511372157;4188.790560471964;4135.421041054255;4254.893627659271;4259.765712885759;4264.57354264571;4264.957350426518;4721.858344249678;4731;4732;4741.478437371887;4802.47869868322;5496.780128794883;5523.254360661259;5525.226468294442;5541.667499950016;5546.084895992197;1351.6553278913814;1432.992835035839;1458.3510337899534;1460.6494441334003;1461.861123193295;992.811365840488;1007.7984403119259;1022.1465076661071;1028.6965345223177;1034.1933292032227;5215.374155101412;5230.241614965808;5234.633575649744;5238.554722848525;5268.841934741964;5468.234447177399;5598.664080155204;5613.326400831927;5625.54995600351;5648.519875810603;5242.947570524322;5245.318108645852;5288.889333240063;5291.656042357235;5331.5201631853315;2984.8955286564865;2996.6553846307515;3000.2799328161086;3006.293521022558;3008.9097327079785;5553.416891226363;5725.742341594639;5791.652500849962;5797.159411885253;5797.768089276382;5713;5738.995675756726;5742.105105315236;5742.54059675225;5759.740811663485;5761.3950535194035;5761.423857614205;5774.249347584787;5775.422457754275;5846.4153584642045;5341.332333458317;5501.9174712380145;5548.056830338772;5550;5552.611317207757;5499.202615620793;5502.80740174092;5532.391436942014;5572.3034620672415;5601.60788744784;5544.861378465571;5719.599628025998;5789.305283366023;5797;5821.719221771204;4138.606832350922;4149.730267532601;4149.813258403318;4167.229062623424;4171.311733563928;5630;5635.6618602883955;5654.953833540808;5664.830055098354;5679.091345384719;5342.465753424626;5496.890062198654;5533.806316778893;5547.362053363915;5554.861128471821;5376.408595054462;5423.538999184956;5425.728713564385;5431.185322201543;5433.266509021231;5209.609279303992;5292.788288468572;5393.6224464287125;5401.974894059339;5434.592405569677;5556.555475562026;5563.693996830051;5568.721563921868;5569.359523654832;5572.60991730575;5441.863953401038;5442.489594211632;5446.128619420873;5451.727413629382;5451.945480545302 13:36:41 INFO - PROCESS | 5007 | |5;yui.html;753.1564647594695;755.867723148449;776.68156056017;811.6307080278474;866.6186877773779;15157.469488567902;16328.101954392534;16342.673146537061;16355.34578616857;16437.835621643793;14380.137191768501;14721.116732996;14820.481283155092;14942;14966.700665986673;800.6597196191624;818.5579786915059;819.315871247509;820.1183727492969;820.188013866271;667.0760996020522;787.759733281349;811.0996793559144;812.597764106768;818.9967290069646;844.5481667307992;845.6025667936091;848.1221935296969;848.4145939301893;849.2484151525882;841.772721365228;842.4776638484118;842.692417267699;842.7429633961669;843.3801156150255;507.21128644957076;602.3344204653882;617.034341255933;617.4072890025581;621.018790311307;14250.2162381069;14285.642858928506;14307.213103279315;14312.856871431257;14333.713325733532;13809.792853107212;14122.85877141236;14493.855061449356;14517.927410362987;14580.198089105095;13018.674533136653;13162.07865449419;13218.933905330508;13227.86772132276;13273.425161432222;4417.580329868657;4486.55134486552;4536.047430039695;4550.977245113753;4691.859244222679;68979.31020689779;69243;72087.63956180186;75782;76590.23409765943;10990.17573681977;11392.20254582188;11474;11502.94248528752;11520.94239528797;18479.260829566934;18659.44021679352;18702.158402871904;18706.906465467586;18785.81214187868;8354.28988535969;8388.8741668875;8617.310615150773;8733.51965641883;8796.91203087961;4611.446626404853;4767.261074533453;4773.331733557305;4795.784189711401;4944.307796908436;3462.740294477924;3538.610752817188;3563.803990780532;3564.4475106358036;3568.6074531801482;601.6269912654095;612.3814946903659;621.0745988477137;621.8818424499331;627.028106435033;516.894036722471;543.4648109009748;555.9805406810742;641.0890599339132;656.3961155736733;8610.268127209258;9012.774680633036;9077.591508382138;9169.35814492979;9355.204807591295;650.5738741124571;656.4125108028288;656.5108993799649;656.5240200854342;679.11375654771;4515.187266292033;4536.4102666653125;4544.409226800561;4582.610478109398;4661.66977940048;62828;115548.42225788817;117654.41172794253;117905;122663.3866830678;99934;103709.48145259226;105092;105150;105729.47135264275;64950.67524662441;84335;87412.5629371849;88214.55892720495;92805.07194928099;8607.708843673248;8733.737987860375;8881.156290152425;8924.107589241024;8949.149830766068;50923.236151457015;51784.48215517797;53745.73127134339;54095.251405013696;54253.18620220621;74608.62695686487;79352.88814508206;80659.59670201612;80725;81348.18651813643;11487.540498380306;11574.305541667527;11701.531938722355;11769.234999724991;11866.288022718665;14248.501302454364;14414.42342306296;14714.705705885608;15370.538883833502;15638.530844074696;13376.933115334361;13602.795958060438;13680.110792798436;13827.585172444842;14106.858931410965;11887.821682674594;12469.625911222678;12859.29273889945;14022.78965815534;14223.502177423741;12968;13133.34333283351;13372.398242079324;13653.860481287564;13798;11752.353620550952;11818.704532386759;11820.23168494045;11922.463489143183;12387.442565084773;10227;11097.611583594535;11740.941295293469;12098.395080246128;12201.07174278149 13:36:41 INFO - PROCESS | 5007 | __end_tp_report 13:36:41 INFO - PROCESS | 5007 | __start_cc_report 13:36:41 INFO - PROCESS | 5007 | _x_x_mozilla_cycle_collect,1063 13:36:41 INFO - PROCESS | 5007 | __end_cc_report 13:36:41 INFO - PROCESS | 5007 | __startTimestamp1469392601987__endTimestamp 13:36:41 INFO - PROCESS | 5007 | 13:36:41 INFO - PROCESS | 5007 | ------- Summary: start ------- 13:36:41 INFO - PROCESS | 5007 | Number of tests: 6 13:36:41 INFO - PROCESS | 5007 | 13:36:41 INFO - PROCESS | 5007 | [#0] dojo.html Cycles:165 Average:5262.23 Median:5440.16 stddev:586.70 (10.8%) stddev-sans-first:561.72 13:36:41 INFO - PROCESS | 5007 | Values: 3028.6 3028.9 3064.4 3065.7 3073.4 5140.9 5202.2 5208.6 5256.9 5347.3 5320.1 5330.4 5389.8 5429.0 5487.5 4830.7 4833.5 4867.6 4876.9 4994.5 4938.7 4964.2 4974.7 4976.2 4977.6 4767.9 4776.9 4812.5 4922.6 4933.4 4751.0 4758.3 4829.1 4831.7 4885.0 4759.5 4819.0 4833.9 4837.8 4863.9 5321.8 5333.5 5364.2 5379.2 5388.5 5433.0 5548.8 5581.4 5585.3 5677.1 5685.9 5715.6 5716.5 5723.4 5723.7 5293.4 5321.0 5326.4 5331.0 5331.3 5637.2 5684.6 5689.8 5760.8 5763.5 5538.7 5551.4 5584.5 5593.2 5659.3 5688.6 5730.5 5736.7 5741.3 5745.6 5579.3 5671.7 5677.7 5677.8 5680.5 5387.2 5623.9 5684.1 5686.4 5758.2 4340.3 4342.4 4346.3 4359.0 4386.5 3860.2 3871.6 3881.7 3925.7 3939.2 5183.2 5199.0 5239.7 5259.4 5300.4 5646.0 5662.2 5669.8 5698.9 5705.3 5307.9 5311.0 5315.3 5318.6 5322.4 4793.6 4864.9 4883.8 4896.1 4934.6 5821.4 5886.1 5895.5 5930.1 5931.9 5676.8 5677.0 5680.1 5700.8 5707.9 5500.4 5676.1 5800.0 5856.1 5868.9 5520.9 5567.7 5587.8 5608.9 5619.9 5639.8 5672.4 5682.1 5682.3 5690.4 5321.9 5417.5 5550.3 5551.1 5552.4 5466.3 5512.4 5513.0 5555.6 5558.8 5404.2 5437.7 5440.2 5444.8 5447.2 5348.5 5526.3 5571.3 5581.8 5584.0 5434.9 5479.9 5520.4 5546.9 5550.4 13:36:41 INFO - PROCESS | 5007 | 13:36:42 INFO - PROCESS | 5007 | [#1] ext.html Cycles:180 Average:60426.55 Median:42540.86 stddev:118644.72 (278.9%) stddev-sans-first:118892.48 13:36:42 INFO - PROCESS | 5007 | Values: 587.7 611.7 615.3 630.4 637.3 43002.8 44155.0 44170.8 44370.3 47503.0 46116.0 46523.3 46524.3 46537.0 46570.0 8953.6 9069.2 9076.2 9076.4 9080.9 8955.5 9068.1 9068.4 9070.2 9070.5 9095.4 9139.3 9142.5 9145.1 9153.5 9044.1 9053.6 9082.9 9098.3 9106.7 8987.3 9006.1 9034.5 9046.4 9061.5 41375.3 41455.4 41641.0 41697.4 41760.0 3445.6 3565.7 3573.3 3593.6 3686.9 32852.5 32984.8 33271.3 33317.3 33374.7 4415.5 4494.4 4511.3 4599.8 4617.4 376311.0 378770.0 379795.0 380257.1 380921.0 52309.5 52513.7 52545.5 52651.0 52653.0 61403.4 61427.7 61484.7 61487.7 61518.7 16335.0 16444.5 16479.4 16489.8 16505.8 12865.4 12913.4 12915.6 12921.7 12924.5 14921.5 16139.9 16192.6 16294.4 16687.4 5943.9 5998.3 6066.3 6071.1 6113.0 985.6 1034.0 1053.6 1063.1 1069.0 32562.0 33335.3 33551.5 33665.8 33979.8 941.9 1083.3 1086.6 1088.8 1161.5 15906.8 16374.9 16457.7 16489.7 16671.2 540987.0 543650.0 544821.0 545458.0 571941.0 58258.1 58417.7 58433.7 58479.0 58515.0 1249.4 1343.2 1354.6 1369.5 1375.7 31624.2 32602.5 33445.7 33607.7 34078.0 50422.0 51030.5 51089.0 51110.7 51117.7 393112.0 393368.0 394602.0 394796.0 396329.0 27318.7 28478.4 28485.3 29269.9 29525.0 48531.8 48535.8 48842.5 48895.8 50355.5 41386.2 41388.0 42230.4 43431.3 43557.0 41867.8 42154.8 42569.6 43447.8 43790.6 41090.6 42273.4 42512.1 42667.5 42792.6 35366.0 37474.2 37985.0 38359.4 38904.6 28315.6 28375.3 28707.7 28722.9 28873.9 13:36:42 INFO - PROCESS | 5007 | 13:36:42 INFO - PROCESS | 5007 | [#2] jquery.html Cycles:180 Average:30012.79 Median:23181.57 stddev:87244.60 (376.4%) stddev-sans-first:87460.95 13:36:42 INFO - PROCESS | 5007 | Values: 367.7 373.9 393.9 396.9 416.1 17098.9 19128.9 19255.3 19401.0 19964.4 14994.6 15006.2 15134.2 15244.3 18283.6 5658.7 5855.3 5863.6 5865.9 5871.8 5517.5 5696.7 5723.2 5726.4 5732.5 5718.9 5723.5 5727.9 5728.3 5731.4 5503.4 5727.8 5765.7 5775.2 5781.3 5121.2 5135.2 5142.5 5171.9 5177.8 21715.1 23290.8 23345.8 23362.4 23630.9 2169.8 2266.4 2328.5 2434.4 2823.7 9792.2 9823.5 10209.9 10502.9 10711.6 1863.7 1908.6 1948.1 1949.1 2008.0 78042.0 84263.6 86198.0 87224.0 88228.0 10828.8 11005.7 11070.3 11116.8 11306.7 15415.6 15438.5 15462.8 15470.8 15526.9 8128.3 8236.1 8375.9 8396.2 8437.7 7778.5 7810.9 7811.3 8061.0 8217.3 4671.7 4719.6 4763.8 4854.8 4875.0 1884.8 2017.8 2022.2 2026.5 2029.7 884.9 961.3 1017.5 1026.2 1038.2 18635.6 19103.4 19507.2 19549.7 19791.5 953.8 972.2 994.5 999.6 1002.5 10382.9 10663.6 10946.3 11027.2 11028.4 521495.0 525128.0 530454.0 533930.0 537776.0 71162.0 73475.0 94070.0 96063.5 98942.0 852.2 888.6 889.4 892.2 892.9 17754.2 17904.2 18361.4 18365.5 18432.0 32140.5 34477.3 45947.0 46269.5 47304.8 63706.7 63906.0 64190.4 64355.0 64617.7 7719.5 8258.0 8609.8 8676.2 8678.7 7561.1 9917.0 11184.0 12480.3 13338.7 10279.5 10675.0 10989.8 11476.5 11544.4 10433.9 10989.3 11209.6 11465.1 11508.7 11590.7 11638.6 11710.5 11739.1 11780.6 8468.7 8605.5 8669.3 8714.8 8854.5 8676.2 10365.4 11063.4 11173.5 11420.0 13:36:42 INFO - PROCESS | 5007 | 13:36:42 INFO - PROCESS | 5007 | [#3] mootools.html Cycles:180 Average:5783.50 Median:2499.81 stddev:3361.71 (134.5%) stddev-sans-first:3355.26 13:36:42 INFO - PROCESS | 5007 | Values: 1435.3 1493.2 1586.5 1659.2 1726.2 8489.1 8952.5 8972.6 9001.7 9009.9 7567.7 8369.1 8619.2 8658.3 8749.6 2309.7 2339.9 2340.6 2340.7 2342.5 2296.0 2302.3 2385.4 2391.6 2393.3 2346.6 2349.3 2358.3 2376.9 2390.5 2232.2 2246.1 2253.8 2257.9 2313.6 2287.3 2290.7 2294.5 2296.7 2298.8 8918.6 9051.4 9067.1 9067.4 9075.5 5153.2 5321.1 5321.2 5325.7 5328.7 3132.8 3158.2 3323.6 3324.3 3326.7 1097.5 1112.8 1133.9 1150.8 1162.9 12472.3 12473.6 12558.6 12571.9 12578.1 4338.8 4453.2 4549.3 4588.2 4589.6 10472.4 10480.4 10498.3 10506.4 10509.6 5257.9 5266.2 5274.1 5279.9 5280.3 4322.7 4745.3 4811.9 4820.3 4845.6 3816.6 3954.8 3959.0 3965.7 4034.5 1249.2 1258.1 1273.6 1288.9 1321.7 910.5 933.4 947.5 961.9 996.7 5637.3 5712.1 5903.9 5931.4 6101.5 448.0 449.1 450.3 458.5 460.5 3949.7 4068.7 4077.0 4080.7 4133.6 10325.6 11090.0 11123.2 11202.6 11232.9 10878.7 10935.2 11001.6 11007.7 11035.1 8206.3 8322.3 8343.3 8354.5 8356.0 5695.8 5697.5 5764.9 5812.9 5913.6 10090.9 10119.4 10161.1 10164.3 10299.1 10199.6 10513.9 10628.1 10653.5 10761.3 7071.6 7634.2 7811.2 7910.1 7970.1 8334.9 8452.3 8528.6 8531.5 8545.0 7547.0 7644.3 7846.0 7921.3 7958.6 7458.3 7569.4 7582.3 7597.9 7696.8 6334.2 6440.5 6441.2 6445.1 6447.2 4815.2 4990.8 5015.9 5187.4 5211.7 5062.4 5193.2 5236.7 5270.7 5276.9 13:36:42 INFO - PROCESS | 5007 | 13:36:42 INFO - PROCESS | 5007 | [#4] prototype.html Cycles:180 Average:4658.76 Median:5278.87 stddev:1333.89 (25.3%) stddev-sans-first:1297.43 13:36:42 INFO - PROCESS | 5007 | Values: 328.7 333.0 335.9 337.8 345.6 5345.8 5372.1 5383.2 5385.4 5406.7 5069.4 5158.4 5164.8 5205.5 5378.9 4080.0 4091.6 4155.8 4189.9 4215.7 4133.3 4139.5 4175.3 4191.0 4244.5 4073.7 4139.5 4176.1 4191.7 4204.1 4132.3 4160.0 4175.6 4177.6 4185.4 3697.3 3712.1 3714.9 3716.0 3742.4 4967.7 5161.8 5163.8 5173.9 5189.9 4727.7 4743.4 4743.4 4753.7 4763.5 5441.1 5459.0 5485.3 5496.6 5505.2 3963.3 4040.1 4041.7 4048.4 4090.1 5669.8 5678.6 5705.0 5736.1 5749.6 4138.2 4145.3 4165.8 4182.0 4188.8 4135.4 4254.9 4259.8 4264.6 4265.0 4721.9 4731.0 4732.0 4741.5 4802.5 5496.8 5523.3 5525.2 5541.7 5546.1 1351.7 1433.0 1458.4 1460.6 1461.9 992.8 1007.8 1022.1 1028.7 1034.2 5215.4 5230.2 5234.6 5238.6 5268.8 5468.2 5598.7 5613.3 5625.5 5648.5 5242.9 5245.3 5288.9 5291.7 5331.5 2984.9 2996.7 3000.3 3006.3 3008.9 5553.4 5725.7 5791.7 5797.2 5797.8 5713.0 5739.0 5742.1 5742.5 5759.7 5761.4 5761.4 5774.2 5775.4 5846.4 5341.3 5501.9 5548.1 5550.0 5552.6 5499.2 5502.8 5532.4 5572.3 5601.6 5544.9 5719.6 5789.3 5797.0 5821.7 4138.6 4149.7 4149.8 4167.2 4171.3 5630.0 5635.7 5655.0 5664.8 5679.1 5342.5 5496.9 5533.8 5547.4 5554.9 5376.4 5423.5 5425.7 5431.2 5433.3 5209.6 5292.8 5393.6 5402.0 5434.6 5556.6 5563.7 5568.7 5569.4 5572.6 5441.9 5442.5 5446.1 5451.7 5451.9 13:36:42 INFO - PROCESS | 5007 | 13:36:42 INFO - PROCESS | 5007 | [#5] yui.html Cycles:180 Average:20636.13 Median:4597.03 stddev:29883.66 (650.1%) stddev-sans-first:29930.20 13:36:42 INFO - PROCESS | 5007 | Values: 753.2 755.9 776.7 811.6 866.6 15157.5 16328.1 16342.7 16355.3 16437.8 14380.1 14721.1 14820.5 14942.0 14966.7 800.7 818.6 819.3 820.1 820.2 667.1 787.8 811.1 812.6 819.0 844.5 845.6 848.1 848.4 849.2 841.8 842.5 842.7 842.7 843.4 507.2 602.3 617.0 617.4 621.0 14250.2 14285.6 14307.2 14312.9 14333.7 13809.8 14122.9 14493.9 14517.9 14580.2 13018.7 13162.1 13218.9 13227.9 13273.4 4417.6 4486.6 4536.0 4551.0 4691.9 68979.3 69243.0 72087.6 75782.0 76590.2 10990.2 11392.2 11474.0 11502.9 11520.9 18479.3 18659.4 18702.2 18706.9 18785.8 8354.3 8388.9 8617.3 8733.5 8796.9 4611.4 4767.3 4773.3 4795.8 4944.3 3462.7 3538.6 3563.8 3564.4 3568.6 601.6 612.4 621.1 621.9 627.0 516.9 543.5 556.0 641.1 656.4 8610.3 9012.8 9077.6 9169.4 9355.2 650.6 656.4 656.5 656.5 679.1 4515.2 4536.4 4544.4 4582.6 4661.7 62828.0 115548.4 117654.4 117905.0 122663.4 99934.0 103709.5 105092.0 105150.0 105729.5 64950.7 84335.0 87412.6 88214.6 92805.1 8607.7 8733.7 8881.2 8924.1 8949.1 50923.2 51784.5 53745.7 54095.3 54253.2 74608.6 79352.9 80659.6 80725.0 81348.2 11487.5 11574.3 11701.5 11769.2 11866.3 14248.5 14414.4 14714.7 15370.5 15638.5 13376.9 13602.8 13680.1 13827.6 14106.9 11887.8 12469.6 12859.3 14022.8 14223.5 12968.0 13133.3 13372.4 13653.9 13798.0 11752.4 11818.7 11820.2 11922.5 12387.4 10227.0 11097.6 11740.9 12098.4 12201.1 13:36:42 INFO - PROCESS | 5007 | -------- Summary: end -------- 13:36:42 INFO - PROCESS | 5007 | 13:36:42 INFO - TEST-INFO | 5007: exit 0 13:36:42 INFO - TEST-OK | dromaeo_css | took 1113691ms 13:36:42 INFO - TEST-START | kraken 13:36:42 INFO - operating with platform_type : linux_ 13:36:42 INFO - Initialising browser for kraken test... 13:36:42 INFO - TEST-INFO | started process 5192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2jcPik/profile http://localhost:59950/getInfo.html) 13:36:46 INFO - PROCESS | 5192 | JavaScript error: , line 0: uncaught exception: undefined 13:36:46 INFO - PROCESS | 5192 | __metrics Screen width/height:1600/1200 13:36:46 INFO - PROCESS | 5192 | colorDepth:24 13:36:46 INFO - PROCESS | 5192 | Browser inner width/height: 1024/697 13:36:46 INFO - PROCESS | 5192 | __metrics 13:36:47 INFO - PROCESS | 5192 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:36:47 INFO - PROCESS | 5192 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:36:48 INFO - TEST-INFO | 5192: exit 0 13:36:48 INFO - Browser initialized. 13:36:48 INFO - Running cycle 1/1 for kraken test... 13:36:48 INFO - TEST-INFO | started process 5276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2jcPik/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:00 INFO - PROCESS | 5276 | RSS: Main: 157913088 13:37:00 INFO - PROCESS | 5276 | 13:37:02 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59950/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:03 INFO - PROCESS | 5276 | RSS: Main: 214540288 13:37:03 INFO - PROCESS | 5276 | 13:37:06 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59950/tests/kraken/driver.html?testName=audio-dft) 13:37:07 INFO - PROCESS | 5276 | RSS: Main: 192770048 13:37:07 INFO - PROCESS | 5276 | 13:37:10 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59950/tests/kraken/driver.html?testName=audio-fft) 13:37:10 INFO - PROCESS | 5276 | RSS: Main: 271286272 13:37:10 INFO - PROCESS | 5276 | 13:37:12 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59950/tests/kraken/driver.html?testName=audio-oscillator) 13:37:13 INFO - PROCESS | 5276 | RSS: Main: 180412416 13:37:13 INFO - PROCESS | 5276 | 13:37:15 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59950/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:16 INFO - PROCESS | 5276 | RSS: Main: 185565184 13:37:16 INFO - PROCESS | 5276 | 13:37:19 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59950/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:19 INFO - PROCESS | 5276 | RSS: Main: 220696576 13:37:19 INFO - PROCESS | 5276 | 13:37:23 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59950/tests/kraken/driver.html?testName=imaging-desaturate) 13:37:23 INFO - PROCESS | 5276 | RSS: Main: 221589504 13:37:23 INFO - PROCESS | 5276 | 13:37:26 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59950/tests/kraken/driver.html?testName=json-parse-financial) 13:37:27 INFO - PROCESS | 5276 | RSS: Main: 221057024 13:37:27 INFO - PROCESS | 5276 | 13:37:28 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59950/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:37:29 INFO - PROCESS | 5276 | RSS: Main: 185974784 13:37:29 INFO - PROCESS | 5276 | 13:37:31 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59950/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:37:31 INFO - PROCESS | 5276 | RSS: Main: 190824448 13:37:31 INFO - PROCESS | 5276 | 13:37:33 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59950/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:37:34 INFO - PROCESS | 5276 | RSS: Main: 195612672 13:37:34 INFO - PROCESS | 5276 | 13:37:36 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:37:37 INFO - PROCESS | 5276 | RSS: Main: 188891136 13:37:37 INFO - PROCESS | 5276 | 13:37:40 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:37:40 INFO - PROCESS | 5276 | RSS: Main: 193712128 13:37:40 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | Cycle 1(1): loaded http://localhost:59950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59950/tests/kraken/driver.html?testName=ai-astar) 13:37:42 INFO - PROCESS | 5276 | RSS: Main: 244350976 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | __start_tp_report 13:37:42 INFO - PROCESS | 5276 | _x_x_mozilla_page_load 13:37:42 INFO - PROCESS | 5276 | _x_x_mozilla_page_load_details 13:37:42 INFO - PROCESS | 5276 | |i|pagename|runs| 13:37:42 INFO - PROCESS | 5276 | |0;ai-astar;103;111;112;113;112;111;111;113;110;113 13:37:42 INFO - PROCESS | 5276 | |1;audio-beat-detection;152;117;122;170;119;119;148;118;155;119 13:37:42 INFO - PROCESS | 5276 | |2;audio-dft;161;161;159;162;161;160;161;160;161;161 13:37:42 INFO - PROCESS | 5276 | |3;audio-fft;74;75;75;110;74;75;75;75;99;74 13:37:42 INFO - PROCESS | 5276 | |4;audio-oscillator;85;84;122;84;85;84;123;83;85;132 13:37:42 INFO - PROCESS | 5276 | |5;imaging-gaussian-blur;117;117;116;117;117;116;116;116;118;117 13:37:42 INFO - PROCESS | 5276 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;145;146 13:37:42 INFO - PROCESS | 5276 | |7;imaging-desaturate;96;95;95;95;94;95;95;95;95;95 13:37:42 INFO - PROCESS | 5276 | |8;json-parse-financial;55;51;53;51;51;52;52;61;52;50 13:37:42 INFO - PROCESS | 5276 | |9;json-stringify-tinderbox;61;62;61;61;61;61;61;61;62;62 13:37:42 INFO - PROCESS | 5276 | |10;stanford-crypto-aes;75;76;75;75;76;75;74;78;75;78 13:37:42 INFO - PROCESS | 5276 | |11;stanford-crypto-ccm;120;121;119;124;120;128;122;121;199;132 13:37:42 INFO - PROCESS | 5276 | |12;stanford-crypto-pbkdf2;160;160;161;156;159;169;157;158;154;157 13:37:42 INFO - PROCESS | 5276 | |13;stanford-crypto-sha256-iterative;65;63;63;62;63;61;63;63;62;61 13:37:42 INFO - PROCESS | 5276 | __end_tp_report 13:37:42 INFO - PROCESS | 5276 | __start_cc_report 13:37:42 INFO - PROCESS | 5276 | _x_x_mozilla_cycle_collect,1700 13:37:42 INFO - PROCESS | 5276 | __end_cc_report 13:37:42 INFO - PROCESS | 5276 | __startTimestamp1469392662798__endTimestamp 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | ------- Summary: start ------- 13:37:42 INFO - PROCESS | 5276 | Number of tests: 14 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.96 (2.6%) stddev-sans-first:1.09 13:37:42 INFO - PROCESS | 5276 | Values: 103.0 111.0 112.0 113.0 112.0 111.0 111.0 113.0 110.0 113.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:135.00 stddev:20.06 (14.9%) stddev-sans-first:20.18 13:37:42 INFO - PROCESS | 5276 | Values: 152.0 117.0 122.0 170.0 119.0 119.0 148.0 118.0 155.0 119.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 13:37:42 INFO - PROCESS | 5276 | Values: 161.0 161.0 159.0 162.0 161.0 160.0 161.0 160.0 161.0 161.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.87 (17.2%) stddev-sans-first:13.43 13:37:42 INFO - PROCESS | 5276 | Values: 74.0 75.0 75.0 110.0 74.0 75.0 75.0 75.0 99.0 74.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:84.00 stddev:20.17 (24.0%) stddev-sans-first:20.94 13:37:42 INFO - PROCESS | 5276 | Values: 85.0 84.0 122.0 84.0 85.0 84.0 123.0 83.0 85.0 132.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 13:37:42 INFO - PROCESS | 5276 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 118.0 117.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 13:37:42 INFO - PROCESS | 5276 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 13:37:42 INFO - PROCESS | 5276 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:52.00 stddev:3.19 (6.1%) stddev-sans-first:3.28 13:37:42 INFO - PROCESS | 5276 | Values: 55.0 51.0 53.0 51.0 51.0 52.0 52.0 61.0 52.0 50.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 13:37:42 INFO - PROCESS | 5276 | Values: 61.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 62.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.50 stddev:1.34 (1.8%) stddev-sans-first:1.39 13:37:42 INFO - PROCESS | 5276 | Values: 75.0 76.0 75.0 75.0 76.0 75.0 74.0 78.0 75.0 78.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:123.00 stddev:24.38 (19.8%) stddev-sans-first:25.55 13:37:42 INFO - PROCESS | 5276 | Values: 120.0 121.0 119.0 124.0 120.0 128.0 122.0 121.0 199.0 132.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.50 stddev:4.07 (2.6%) stddev-sans-first:4.30 13:37:42 INFO - PROCESS | 5276 | Values: 160.0 160.0 161.0 156.0 159.0 169.0 157.0 158.0 154.0 157.0 13:37:42 INFO - PROCESS | 5276 | 13:37:42 INFO - PROCESS | 5276 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.17 (1.9%) stddev-sans-first:0.87 13:37:42 INFO - PROCESS | 5276 | Values: 65.0 63.0 63.0 62.0 63.0 61.0 63.0 63.0 62.0 61.0 13:37:42 INFO - PROCESS | 5276 | -------- Summary: end -------- 13:37:42 INFO - PROCESS | 5276 | 13:37:43 INFO - TEST-INFO | 5276: exit 0 13:37:43 INFO - TEST-OK | kraken | took 61018ms 13:37:43 INFO - SUITE-END | took 1174s 13:37:43 INFO - Completed test suite (00:19:34) 13:37:43 INFO - javascript benchmark 13:37:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3028.636563612367, 3028.909132726018, 3064.3718037802255, 3065.7087576680206, 3073.4314151881904, 5140.8971820563565, 5202.245674377223, 5208.557272631826, 5256.92114618281, 5347.251384806125, 5320.095583750762, 5330.413654498012, 5389.83830485086, 5428.972855135718, 5487.451254874521, 4830.73430961297, 4833.516648335165, 4867.610591152699, 4876.902461950776, 4994.525520075587, 4938.678985865925, 4964.180910149821, 4974.676646018015, 4976.228684553882, 4977.55202031817, 4767.928481072787, 4776.880577985544, 4812.542808433193, 4922.606191504671, 4933.358663373757, 4750.976245118787, 4758.262469317261, 4829.106615276185, 4831.710097394132, 4884.951150488485, 4759.524047595248, 4818.975905120487, 4833.927491087637, 4837.758112094381, 4863.8784030399165, 5321.840344789663, 5333.546648534879, 5364.195370694427, 5379.1662292344745, 5388.488093631099, 5433.049216387156, 5548.805791797267, 5581.386047534768, 5585.329760428734, 5677.120046392815, 5685.914711279334, 5715.599908006441, 5716.456936591058, 5723.399043100498, 5723.685197314146, 5293.444188360205, 5321.015612111772, 5326.440723723992, 5331.0, 5331.280277162611, 5637.210790489335, 5684.573656975661, 5689.829305120853, 5760.769569217185, 5763.452472015152, 5538.695371754592, 5551.417101204396, 5584.497395234448, 5593.161025846074, 5659.320881494247, 5688.63023903445, 5730.455606717355, 5736.741846616912, 5741.311042674823, 5745.626534275259, 5579.2746942897975, 5671.716414179275, 5677.716114194356, 5677.772889084473, 5680.517156041783, 5387.191921211771, 5623.8875222496135, 5684.147377893349, 5686.3744988051285, 5758.193852860602, 4340.348947657877, 4342.370356298319, 4346.282863327516, 4359.04101097758, 4386.517483076859, 3860.2472517858746, 3871.612838716162, 3881.6700580450415, 3925.685945124383, 3939.212157568498, 5183.170692689152, 5198.974005130026, 5239.659422137549, 5259.368875734936, 5300.44345343741, 5646.040173170571, 5662.207290979266, 5669.829905102853, 5698.943010569841, 5705.315362156568, 5307.867303317448, 5311.044012077786, 5315.255864179018, 5318.627696061239, 5322.414534401213, 4793.592544633675, 4864.902701945941, 4883.780229889663, 4896.143174944442, 4934.605231581465, 5821.359650438533, 5886.05823068307, 5895.498882595028, 5930.140129681172, 5931.881362372728, 5676.829695109153, 5676.971615141898, 5680.062789639828, 5700.771969121189, 5707.857303567444, 5500.4224556420995, 5676.063449530946, 5800.0, 5856.0630299151935, 5868.882622347614, 5520.889582208253, 5567.66594004361, 5587.77648894056, 5608.9158662619275, 5619.8595035124445, 5639.830805075854, 5672.432756724294, 5682.090865461506, 5682.261306030189, 5690.374058853606, 5321.920171197513, 5417.485338892799, 5550.250716153268, 5551.08407112838, 5552.416996215339, 5466.34403871538, 5512.3660779010925, 5513.0, 5555.638883472561, 5558.833235002957, 5404.243405923095, 5437.673739575638, 5440.156775699773, 5444.754986025559, 5447.1829225616475, 5348.5186333230195, 5526.253955716088, 5571.331440227199, 5581.776728930798, 5584.0, 5434.864128396822, 5479.863003424946, 5520.420355862737, 5546.889062218814, 5550.361708403424], "value": 5223.1042770824915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.7061469265367, 611.709438016942, 615.3047056825789, 630.4105661206773, 637.2798737426707, 43002.784986075065, 44155.0, 44170.77914610422, 44370.33444498331, 47503.0, 46116.0, 46523.30215046777, 46524.302135467995, 46537.0, 46570.0, 8953.641854325819, 9069.183773460387, 9076.183143517082, 9076.41003334781, 9080.909190908105, 8955.462672239686, 9068.093190680946, 9068.36521443496, 9070.183683468487, 9070.546472676373, 9095.408798428081, 9139.268858491338, 9142.542872856364, 9145.131212534798, 9153.496557689325, 9044.050374710627, 9053.637854485813, 9082.909170908273, 9098.272138228926, 9106.726798196065, 8987.281017518582, 9006.054364291786, 9034.503102329369, 9046.411983221069, 9061.546922653906, 41375.27622513988, 41455.37816932749, 41641.0, 41697.37453938193, 41760.0, 3445.63820798815, 3565.6969157621634, 3573.3032058748554, 3593.586737525192, 3686.870959516404, 32852.507212391836, 32984.83507582471, 33271.3345733084, 33317.33365332704, 33374.6662533374, 4415.51429342772, 4494.37078808967, 4511.323301504768, 4599.816007359702, 4617.353570500132, 376311.0, 378770.0, 379795.0, 380257.0987145074, 380921.0, 52309.47690523122, 52513.7374313126, 52545.47454525406, 52651.0, 52653.0, 61403.38596614066, 61427.692861535405, 61484.69257653683, 61487.692561536904, 61518.69240653768, 16335.0, 16444.506664800076, 16479.423220187477, 16489.83510164883, 16505.752413713803, 12865.356732163355, 12913.354332283348, 12915.612531624067, 12921.741565168832, 12924.483020679256, 14921.477748278758, 16139.919300403422, 16192.595185120466, 16294.429694960856, 16687.415940442028, 5943.940560594425, 5998.310194327621, 6066.332703402622, 6071.089336599457, 6113.0, 985.6205360935948, 1033.9844902326472, 1053.5733028123468, 1063.106990128296, 1068.9518971646294, 32562.0, 33335.333293334, 33551.49672754911, 33665.831670841486, 33979.830100849336, 941.8681384606024, 1083.3316692293936, 1086.5979587552656, 1088.8475613414128, 1161.4773351991637, 15906.840931590767, 16374.918125409296, 16457.670846583, 16489.6702065958, 16671.16644167811, 540987.0, 543650.0, 544821.0, 545458.0, 571941.0, 58258.12612810811, 58417.70791146017, 58433.70783146057, 58479.0, 58515.0, 1249.419020155632, 1343.1538130977617, 1354.6071639224515, 1369.4932874836375, 1375.69734658375, 31624.209394765316, 32602.51096233606, 33445.665543345225, 33607.66392336143, 34078.0, 50422.0, 51030.48969510257, 51089.0, 51110.74444627753, 51117.74441127919, 393112.0, 393368.0, 394602.0, 394796.0, 396329.0, 27318.726812731617, 28478.43043139167, 28485.287867802643, 29269.85365073161, 29525.0, 48531.757341213066, 48535.75732121317, 48842.5115748838, 48895.75552122216, 50355.49644503508, 41386.1722765537, 41388.0, 42230.366544501245, 43431.34852977144, 43557.0, 41867.7906610465, 42154.789226053676, 42569.57430425656, 43447.78276108599, 43790.56209437865, 41090.58909410868, 42273.365899512144, 42512.14975700407, 42667.51991040896, 42792.572074280106, 35366.0, 37474.16030325206, 37985.0, 38359.42460863145, 38904.61095389123, 28315.575266371434, 28375.29061773472, 28707.71292287134, 28722.856385717936, 28873.85563072171], "value": 20146.094479249434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.71685801932495, 373.9252149570085, 393.88971088095343, 396.89283893348795, 416.14482238998863, 17098.91450542747, 19128.904355478222, 19255.326063587778, 19401.0, 19964.40106796795, 14994.550163495085, 15006.174660393674, 15134.24328783562, 15244.314005869735, 18283.634327313444, 5658.745356458949, 5855.297364316267, 5863.618864773797, 5865.8826823463505, 5871.765129394819, 5517.475839795213, 5696.746715722535, 5723.198752174699, 5726.3987281335485, 5732.48407643312, 5718.857028574277, 5723.4848863602265, 5727.914081288784, 5728.341240757304, 5731.398203188668, 5503.449655034505, 5727.799527016556, 5765.711714414305, 5775.249217601727, 5781.306243250816, 5121.2318152277085, 5135.204043373283, 5142.460041695643, 5171.922421163686, 5177.792888284464, 21715.13139474435, 23290.767092329028, 23345.766542334528, 23362.415939601477, 23630.881845590833, 2169.804717575426, 2266.444721043355, 2328.4760928791056, 2434.415740222352, 2823.6611606607134, 9792.21662267017, 9823.459709715962, 10209.89790102097, 10502.9474852626, 10711.625093121782, 1863.6738570750065, 1908.5801123752751, 1948.0844003318418, 1949.083930552638, 2008.0, 78042.0, 84263.5786821068, 86198.0, 87224.0, 88228.0, 10828.78342433147, 11005.669829905115, 11070.28043177191, 11116.777664446667, 11306.660800176009, 15415.61460963485, 15438.5368438947, 15462.768058479132, 15470.845291547166, 15526.913116081992, 8128.268455839003, 8236.094029656733, 8375.874361884577, 8396.160383961555, 8437.704680336281, 7778.455508114378, 7810.873961789929, 7811.336036436853, 8060.959695201486, 8217.34261259098, 4671.7430541320555, 4719.5752382285755, 4763.833265835679, 4854.80580776765, 4874.975625121922, 1884.7644044494439, 2017.7578690556934, 2022.1911235505622, 2026.533897203622, 2029.7462817147857, 884.9070847560913, 961.2790407194605, 1017.4759998600726, 1026.2046913641987, 1038.190211634926, 18635.627287454176, 19103.426897193105, 19507.219711211677, 19549.706754398696, 19791.505212369517, 953.77109493721, 972.179335212607, 994.4629899854142, 999.6201443451442, 1002.5387673262125, 10382.896171038345, 10663.573457061631, 10946.343219406861, 11027.17296202772, 11028.44857757109, 521495.0, 525128.0, 530454.0, 533930.0, 537776.0, 71162.0, 73475.0, 94070.0, 96063.51968240114, 98942.0, 852.2117041736369, 888.626776753765, 889.4352086425038, 892.2148509311764, 892.8839250897472, 17754.20106095203, 17904.194311256284, 18361.449156525327, 18365.54086147857, 18431.984156455008, 32140.517892232103, 34477.31045379129, 45947.0, 46269.53730462652, 47304.7634761824, 63706.681466592374, 63906.0, 64190.35809642031, 64355.0, 64617.67691161514, 7719.498232614862, 8257.95871020641, 8609.784755381166, 8676.219140277406, 8678.739637810622, 7561.130469996021, 9917.0, 11184.0, 12480.313582753035, 13338.666533336356, 10279.537420815932, 10674.985876341736, 10989.835152472559, 11476.483558239732, 11544.422778860855, 10433.895661043292, 10989.340639561651, 11209.607663731731, 11465.14011449128, 11508.654740357802, 11590.71023224426, 11638.592649257236, 11710.4730287139, 11739.06087513014, 11780.646580602595, 8468.703595374132, 8605.451018816422, 8669.30645548342, 8714.825703486022, 8854.468731876108, 8676.175763302475, 10365.429901355497, 11063.391513466837, 11173.49719262619, 11420.0], "value": 9077.835580957546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.33974371789, 1493.2011373914954, 1586.4606033948455, 1659.2450435052053, 1726.15418444962, 8489.108643592426, 8952.462852228871, 8972.641094356219, 9001.684941027057, 9009.90990090098, 7567.735129270477, 8369.121242269566, 8619.181177788116, 8658.307335413168, 8749.606267717953, 2309.7343805462333, 2339.94150146246, 2340.6137987232087, 2340.707411573553, 2342.508073304608, 2295.988520057406, 2302.2747834432103, 2385.3917251100943, 2391.5934291170543, 2393.2939782764124, 2346.6480027995767, 2349.283468542094, 2358.3043002314357, 2376.940576485593, 2390.497995420964, 2232.218723446797, 2246.067881829039, 2253.752087270391, 2257.909683612662, 2313.6066868632206, 2287.2795069553035, 2290.6678531612824, 2294.4837411582425, 2296.712910886139, 2298.8275879308953, 8918.643254269822, 9051.41165824226, 9067.093290670946, 9067.410618309788, 9075.54622268884, 5153.175491921312, 5321.148616221425, 5321.2284218788445, 5325.707086110262, 5328.680279183222, 3132.8120312781307, 3158.178873492908, 3323.567936168307, 3324.268660894599, 3326.7172290355347, 1097.5335482420019, 1112.7663190729875, 1133.9036181924546, 1150.7986102432124, 1162.9185956983015, 12472.251664900135, 12473.563425280072, 12558.623241302776, 12571.93714031424, 12578.056645751514, 4338.76136812472, 4453.198424283595, 4549.340345649863, 4588.151192029485, 4589.58693717567, 10472.37165770041, 10480.423576703355, 10498.317609355367, 10506.369617822955, 10509.579616815394, 5257.947420525822, 5266.183741520071, 5274.103402421598, 5279.947200528022, 5280.313559237351, 4322.7190232634775, 4745.335653008581, 4811.879703007453, 4820.276958456189, 4845.5881250093435, 3816.6183381661613, 3954.7824869632445, 3959.0, 3965.7422267552515, 4034.536028356718, 1249.1693024139026, 1258.1193164784688, 1273.6433798536425, 1288.8711128887037, 1321.6960099177052, 910.5265262063822, 933.3513208320152, 947.507296205969, 961.927855410847, 996.725900377402, 5637.3235211774845, 5712.0860662293835, 5903.881922361528, 5931.377205393372, 6101.511879049665, 447.95296493868324, 449.138321656731, 450.2818005281571, 458.5368777534714, 460.452062046164, 3949.664278536299, 4068.7355321903983, 4077.0, 4080.6531444827524, 4133.594577843548, 10325.63860264887, 11090.0, 11123.221374503868, 11202.607908723156, 11232.943835280772, 10878.673639790819, 10935.234533582572, 11001.61494347694, 11007.669769906915, 11035.117190624731, 8206.302464290482, 8322.29260512851, 8343.290820280345, 8354.45696029756, 8356.0, 5695.800646977336, 5697.54419646419, 5764.913526297025, 5812.854678633068, 5913.645181289136, 10090.88091500793, 10119.392836429837, 10161.085502304531, 10164.33931794431, 10299.073083422529, 10199.643012494527, 10513.89486105129, 10628.096611788085, 10653.455248988697, 10761.30051546647, 7071.611061391673, 7634.198409166957, 7811.218878112143, 7910.129885712452, 7970.083440404428, 8334.874976875473, 8452.32381409498, 8528.573571321533, 8531.53076580794, 8545.0, 7547.018887544584, 7644.273793989562, 7846.0, 7921.32668723142, 7958.602069896367, 7458.254174582498, 7569.394448444222, 7582.279683430065, 7597.88603170964, 7696.8460630788195, 6334.208223972004, 6440.516961227833, 6441.1626488556185, 6445.12990746262, 6447.2263328400895, 4815.15734746411, 4990.80036798524, 5015.896502769385, 5187.403448603459, 5211.661242019257, 5062.443131255633, 5193.221016847503, 5236.738163091906, 5270.657407268515, 5276.918231762403], "value": 4533.818219967917, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.72715646013813, 332.9976769922533, 335.9428897087495, 337.78213052581077, 345.55078398082486, 5345.839624811257, 5372.059889519333, 5383.246345511622, 5385.407605163429, 5406.729663516819, 5069.377799104279, 5158.380994280682, 5164.793408263675, 5205.479452054793, 5378.946210537893, 4080.0411903202726, 4091.5703851095654, 4155.792210389483, 4189.937150942738, 4215.732807074511, 4133.318002529579, 4139.544650088488, 4175.269327867626, 4190.9580904191025, 4244.511881133662, 4073.674106071522, 4139.482564679415, 4176.0603864130635, 4191.664666826662, 4204.11713540157, 4132.318167502359, 4159.9792001040105, 4175.62419382257, 4177.624013838754, 4185.393117997888, 3697.2975134724584, 3712.109093817491, 3714.888553343404, 3715.981420092909, 3742.35336451963, 4967.677100988424, 5161.845144645667, 5163.845084647466, 5173.870653233662, 5189.896202075937, 4727.692699974525, 4743.407074115701, 4743.430788305425, 4753.691010084333, 4763.476017638057, 5441.095616534221, 5459.0, 5485.341758988907, 5496.587755918322, 5505.21986396867, 3963.286608410485, 4040.1313717550574, 4041.7372870763306, 4048.412980117896, 4090.141070375225, 5669.801556945487, 5678.5803549112725, 5704.974733969464, 5736.139579063132, 5749.568782341341, 4138.151678905817, 4145.253854306254, 4165.812538435717, 4181.954511372157, 4188.790560471964, 4135.421041054255, 4254.893627659271, 4259.765712885759, 4264.57354264571, 4264.957350426518, 4721.858344249678, 4731.0, 4732.0, 4741.478437371887, 4802.47869868322, 5496.780128794883, 5523.254360661259, 5525.226468294442, 5541.667499950016, 5546.084895992197, 1351.6553278913814, 1432.992835035839, 1458.3510337899534, 1460.6494441334003, 1461.861123193295, 992.811365840488, 1007.7984403119259, 1022.1465076661071, 1028.6965345223177, 1034.1933292032227, 5215.374155101412, 5230.241614965808, 5234.633575649744, 5238.554722848525, 5268.841934741964, 5468.234447177399, 5598.664080155204, 5613.326400831927, 5625.54995600351, 5648.519875810603, 5242.947570524322, 5245.318108645852, 5288.889333240063, 5291.656042357235, 5331.5201631853315, 2984.8955286564865, 2996.6553846307515, 3000.2799328161086, 3006.293521022558, 3008.9097327079785, 5553.416891226363, 5725.742341594639, 5791.652500849962, 5797.159411885253, 5797.768089276382, 5713.0, 5738.995675756726, 5742.105105315236, 5742.54059675225, 5759.740811663485, 5761.3950535194035, 5761.423857614205, 5774.249347584787, 5775.422457754275, 5846.4153584642045, 5341.332333458317, 5501.9174712380145, 5548.056830338772, 5550.0, 5552.611317207757, 5499.202615620793, 5502.80740174092, 5532.391436942014, 5572.3034620672415, 5601.60788744784, 5544.861378465571, 5719.599628025998, 5789.305283366023, 5797.0, 5821.719221771204, 4138.606832350922, 4149.730267532601, 4149.813258403318, 4167.229062623424, 4171.311733563928, 5630.0, 5635.6618602883955, 5654.953833540808, 5664.830055098354, 5679.091345384719, 5342.465753424626, 5496.890062198654, 5533.806316778893, 5547.362053363915, 5554.861128471821, 5376.408595054462, 5423.538999184956, 5425.728713564385, 5431.185322201543, 5433.266509021231, 5209.609279303992, 5292.788288468572, 5393.6224464287125, 5401.974894059339, 5434.592405569677, 5556.555475562026, 5563.693996830051, 5568.721563921868, 5569.359523654832, 5572.60991730575, 5441.863953401038, 5442.489594211632, 5446.128619420873, 5451.727413629382, 5451.945480545302], "value": 4238.7359930022085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.1564647594695, 755.867723148449, 776.68156056017, 811.6307080278474, 866.6186877773779, 15157.469488567902, 16328.101954392534, 16342.673146537061, 16355.34578616857, 16437.835621643793, 14380.137191768501, 14721.116732996, 14820.481283155092, 14942.0, 14966.700665986673, 800.6597196191624, 818.5579786915059, 819.315871247509, 820.1183727492969, 820.188013866271, 667.0760996020522, 787.759733281349, 811.0996793559144, 812.597764106768, 818.9967290069646, 844.5481667307992, 845.6025667936091, 848.1221935296969, 848.4145939301893, 849.2484151525882, 841.772721365228, 842.4776638484118, 842.692417267699, 842.7429633961669, 843.3801156150255, 507.21128644957076, 602.3344204653882, 617.034341255933, 617.4072890025581, 621.018790311307, 14250.2162381069, 14285.642858928506, 14307.213103279315, 14312.856871431257, 14333.713325733532, 13809.792853107212, 14122.85877141236, 14493.855061449356, 14517.927410362987, 14580.198089105095, 13018.674533136653, 13162.07865449419, 13218.933905330508, 13227.86772132276, 13273.425161432222, 4417.580329868657, 4486.55134486552, 4536.047430039695, 4550.977245113753, 4691.859244222679, 68979.31020689779, 69243.0, 72087.63956180186, 75782.0, 76590.23409765943, 10990.17573681977, 11392.20254582188, 11474.0, 11502.94248528752, 11520.94239528797, 18479.260829566934, 18659.44021679352, 18702.158402871904, 18706.906465467586, 18785.81214187868, 8354.28988535969, 8388.8741668875, 8617.310615150773, 8733.51965641883, 8796.91203087961, 4611.446626404853, 4767.261074533453, 4773.331733557305, 4795.784189711401, 4944.307796908436, 3462.740294477924, 3538.610752817188, 3563.803990780532, 3564.4475106358036, 3568.6074531801482, 601.6269912654095, 612.3814946903659, 621.0745988477137, 621.8818424499331, 627.028106435033, 516.894036722471, 543.4648109009748, 555.9805406810742, 641.0890599339132, 656.3961155736733, 8610.268127209258, 9012.774680633036, 9077.591508382138, 9169.35814492979, 9355.204807591295, 650.5738741124571, 656.4125108028288, 656.5108993799649, 656.5240200854342, 679.11375654771, 4515.187266292033, 4536.4102666653125, 4544.409226800561, 4582.610478109398, 4661.66977940048, 62828.0, 115548.42225788817, 117654.41172794253, 117905.0, 122663.3866830678, 99934.0, 103709.48145259226, 105092.0, 105150.0, 105729.47135264275, 64950.67524662441, 84335.0, 87412.5629371849, 88214.55892720495, 92805.07194928099, 8607.708843673248, 8733.737987860375, 8881.156290152425, 8924.107589241024, 8949.149830766068, 50923.236151457015, 51784.48215517797, 53745.73127134339, 54095.251405013696, 54253.18620220621, 74608.62695686487, 79352.88814508206, 80659.59670201612, 80725.0, 81348.18651813643, 11487.540498380306, 11574.305541667527, 11701.531938722355, 11769.234999724991, 11866.288022718665, 14248.501302454364, 14414.42342306296, 14714.705705885608, 15370.538883833502, 15638.530844074696, 13376.933115334361, 13602.795958060438, 13680.110792798436, 13827.585172444842, 14106.858931410965, 11887.821682674594, 12469.625911222678, 12859.29273889945, 14022.78965815534, 14223.502177423741, 12968.0, 13133.34333283351, 13372.398242079324, 13653.860481287564, 13798.0, 11752.353620550952, 11818.704532386759, 11820.23168494045, 11922.463489143183, 12387.442565084773, 10227.0, 11097.611583594535, 11740.941295293469, 12098.395080246128, 12201.07174278149], "value": 7467.380342491306, "unit": "score"}], "name": "dromaeo_css", "value": 7180.744038578217, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 113.0, 112.0, 111.0, 111.0, 113.0, 110.0, 113.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 117.0, 122.0, 170.0, 119.0, 119.0, 148.0, 118.0, 155.0, 119.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 162.0, 161.0, 160.0, 161.0, 160.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 110.0, 74.0, 75.0, 75.0, 75.0, 99.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 122.0, 84.0, 85.0, 84.0, 123.0, 83.0, 85.0, 132.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 118.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 53.0, 51.0, 51.0, 52.0, 52.0, 61.0, 52.0, 50.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 75.0, 76.0, 75.0, 74.0, 78.0, 75.0, 78.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 119.0, 124.0, 120.0, 128.0, 122.0, 121.0, 199.0, 132.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 156.0, 159.0, 169.0, 157.0, 158.0, 154.0, 157.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 62.0, 63.0, 61.0, 63.0, 63.0, 62.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1482.6, "alertThreshold": 2.0}]} 13:37:44 INFO - Return code: 0 13:37:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:37:44 INFO - # TBPL SUCCESS # 13:37:44 INFO - Running post-action listener: _resource_record_post_action 13:37:44 INFO - [mozharness: 2016-07-24 20:37:44.083698Z] Finished run-tests step (success) 13:37:44 INFO - Running post-run listener: _resource_record_post_run 13:37:44 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 229376; Write bytes: 294637568; Read time: 440; Write time: 244880 13:37:44 INFO - TinderboxPrint: CPU usage
13.0% 13:37:44 INFO - TinderboxPrint: I/O read bytes / time
229,376 / 440 13:37:44 INFO - TinderboxPrint: I/O write bytes / time
294,637,568 / 244,880 13:37:44 INFO - TinderboxPrint: CPU idle
8,276.7 (87.0%) 13:37:44 INFO - TinderboxPrint: CPU user
1,192.7 (12.5%) 13:37:44 INFO - TinderboxPrint: Swap in / out
0 / 0 13:37:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1335296; Read time: 0; Write time: 52 13:37:44 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 225280; Write bytes: 293302272; Read time: 428; Write time: 244828 13:37:44 INFO - Running post-run listener: _upload_blobber_files 13:37:44 INFO - Blob upload gear active. 13:37:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:37:44 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 13:37:44 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'] 13:37:44 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 13:37:45 INFO - (blobuploader) - INFO - Open directory for files ... 13:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:37:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:45 INFO - (blobuploader) - INFO - Done attempting. 13:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:37:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:46 INFO - (blobuploader) - INFO - Done attempting. 13:37:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:37:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:37:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:55 INFO - (blobuploader) - INFO - Done attempting. 13:37:55 INFO - (blobuploader) - INFO - Iteration through files over. 13:37:55 INFO - Return code: 0 13:37:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:37:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:37:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4004819498260bb9c6801dcff9694e50c344a149216cbc4b5933e60a5600fce2271218cafef9f484d09869f5c6fbc8cff5150e68dce6ead89eb7adf6c15753f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cec1af8fbb3e1ec92beb2d6d56cd3c706963e3659a02c2474b98da8196c072a9a01935fba5984bf2556b098cc9dfe0225b9589ebba3563ed106975557bbdb7b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/363d800a622c93c3f6ea72d206566dd43f050ef11941d85d1613173e8ddec105ae76c8732d342ee345af8ff964bbef6e6b4042d13c528350232df042af0bc39e"} 13:37:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:37:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:37:55 INFO - Contents: 13:37:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4004819498260bb9c6801dcff9694e50c344a149216cbc4b5933e60a5600fce2271218cafef9f484d09869f5c6fbc8cff5150e68dce6ead89eb7adf6c15753f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cec1af8fbb3e1ec92beb2d6d56cd3c706963e3659a02c2474b98da8196c072a9a01935fba5984bf2556b098cc9dfe0225b9589ebba3563ed106975557bbdb7b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/363d800a622c93c3f6ea72d206566dd43f050ef11941d85d1613173e8ddec105ae76c8732d342ee345af8ff964bbef6e6b4042d13c528350232df042af0bc39e"} 13:37:55 INFO - Running post-run listener: copy_logs_to_upload_dir 13:37:55 INFO - Copying logs to upload dir... 13:37:55 INFO - mkdir: /builds/slave/test/build/upload/logs 13:37:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.859975 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-24 13:37:54.872652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-24 13:37:54.876488) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4004819498260bb9c6801dcff9694e50c344a149216cbc4b5933e60a5600fce2271218cafef9f484d09869f5c6fbc8cff5150e68dce6ead89eb7adf6c15753f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cec1af8fbb3e1ec92beb2d6d56cd3c706963e3659a02c2474b98da8196c072a9a01935fba5984bf2556b098cc9dfe0225b9589ebba3563ed106975557bbdb7b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/363d800a622c93c3f6ea72d206566dd43f050ef11941d85d1613173e8ddec105ae76c8732d342ee345af8ff964bbef6e6b4042d13c528350232df042af0bc39e"} build_url:https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/afELaGZiRjiGuyO-CztgIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4004819498260bb9c6801dcff9694e50c344a149216cbc4b5933e60a5600fce2271218cafef9f484d09869f5c6fbc8cff5150e68dce6ead89eb7adf6c15753f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cec1af8fbb3e1ec92beb2d6d56cd3c706963e3659a02c2474b98da8196c072a9a01935fba5984bf2556b098cc9dfe0225b9589ebba3563ed106975557bbdb7b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/363d800a622c93c3f6ea72d206566dd43f050ef11941d85d1613173e8ddec105ae76c8732d342ee345af8ff964bbef6e6b4042d13c528350232df042af0bc39e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-24 13:37:54.901509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 13:37:54.901808) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469382360.447412-634789123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004367 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 13:37:54.986161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-24 13:37:54.986489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-24 13:37:54.986822) ========= ========= Total master_lag: 0.16 =========