builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1469364596.73 results: success (0) buildid: 20160724030208 builduid: 03194e3b822f4e378cc3c6b8b9ac5b1b revision: e0bc88708ffed39aaab1fbc0ac461d93561195de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:56.741293) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:56.741954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:56.742277) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:56.825912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:56.826216) ========= 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=1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-24 05:49:57-- 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% 46.7M=0s 2016-07-24 05:49:57 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122134 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:56.973355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:56.973717) ========= 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=1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019506 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:57.040890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:57.041278) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e0bc88708ffed39aaab1fbc0ac461d93561195de --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e0bc88708ffed39aaab1fbc0ac461d93561195de --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=1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-24 05:49:57,279 truncating revision to first 12 chars 2016-07-24 05:49:57,279 Setting DEBUG logging. 2016-07-24 05:49:57,279 attempt 1/10 2016-07-24 05:49:57,279 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e0bc88708ffe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-24 05:49:57,607 unpacking tar archive at: mozilla-central-e0bc88708ffe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659097 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:57.724025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:57.724414) ========= script_repo_revision: e0bc88708ffed39aaab1fbc0ac461d93561195de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:57.724875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:57.725185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-24 05:49:57.737143) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-24 05:49:57.737477) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:58 INFO - MultiFileLogger online at 20160724 05:49:58 in /builds/slave/test 05:49:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:49:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:49:58 INFO - {'append_to_log': False, 05:49:58 INFO - 'base_work_dir': '/builds/slave/test', 05:49:58 INFO - 'blob_upload_branch': 'Firefox', 05:49:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:49:58 INFO - 'branch': 'Firefox', 05:49:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:58 INFO - 'config_files': ('talos/linux_config.py',), 05:49:58 INFO - 'default_actions': ('clobber', 05:49:58 INFO - 'read-buildbot-config', 05:49:58 INFO - 'download-and-extract', 05:49:58 INFO - 'populate-webroot', 05:49:58 INFO - 'create-virtualenv', 05:49:58 INFO - 'install', 05:49:58 INFO - 'run-tests'), 05:49:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:58 INFO - 'download_minidump_stackwalk': True, 05:49:58 INFO - 'download_symbols': 'ondemand', 05:49:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:58 INFO - 'installer_path': 'installer.exe', 05:49:58 INFO - 'log_level': 'info', 05:49:58 INFO - 'log_name': 'talos', 05:49:58 INFO - 'log_to_console': True, 05:49:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:58 INFO - 'opt_config_files': (), 05:49:58 INFO - 'pip_index': False, 05:49:58 INFO - 'sps_profile': False, 05:49:58 INFO - 'sps_profile_interval': 0, 05:49:58 INFO - 'suite': 'dromaeojs', 05:49:58 INFO - 'system_bits': '32', 05:49:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:58 INFO - 'title': 'talos-linux64-ix-027', 05:49:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:58 INFO - 'use_talos_json': True, 05:49:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:49:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:58 INFO - 'work_dir': 'build'} 05:49:58 INFO - [mozharness: 2016-07-24 12:49:58.061601Z] Running clobber step. 05:49:58 INFO - Running pre-action listener: _resource_record_pre_action 05:49:58 INFO - Running main action method: clobber 05:49:58 INFO - rmtree: /builds/slave/test/build 05:49:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:49:59 INFO - Running post-action listener: _resource_record_post_action 05:49:59 INFO - [mozharness: 2016-07-24 12:49:59.015362Z] Finished clobber step (success) 05:49:59 INFO - [mozharness: 2016-07-24 12:49:59.015463Z] Running read-buildbot-config step. 05:49:59 INFO - Running pre-action listener: _resource_record_pre_action 05:49:59 INFO - Running main action method: read_buildbot_config 05:49:59 INFO - Using buildbot properties: 05:49:59 INFO - { 05:49:59 INFO - "project": "", 05:49:59 INFO - "product": "firefox", 05:49:59 INFO - "script_repo_revision": "production", 05:49:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:49:59 INFO - "repository": "", 05:49:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:49:59 INFO - "buildid": "20160724030208", 05:49:59 INFO - "stage_platform": "linux64-pgo", 05:49:59 INFO - "basedir": "/builds/slave/test", 05:49:59 INFO - "nightly_build": "True", 05:49:59 INFO - "buildnumber": 803, 05:49:59 INFO - "slavename": "talos-linux64-ix-027", 05:49:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:49:59 INFO - "platform": "ubuntu64_hw", 05:49:59 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:49:59 INFO - "branch": "mozilla-central", 05:49:59 INFO - "repo_path": "mozilla-central", 05:49:59 INFO - "revision": "e0bc88708ffed39aaab1fbc0ac461d93561195de", 05:49:59 INFO - "pgo_build": "True", 05:49:59 INFO - "builduid": "03194e3b822f4e378cc3c6b8b9ac5b1b", 05:49:59 INFO - "slavebuilddir": "test" 05:49:59 INFO - } 05:49:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:49:59 INFO - Running post-action listener: _resource_record_post_action 05:49:59 INFO - [mozharness: 2016-07-24 12:49:59.017993Z] Finished read-buildbot-config step (success) 05:49:59 INFO - [mozharness: 2016-07-24 12:49:59.018083Z] Running download-and-extract step. 05:49:59 INFO - Running pre-action listener: _resource_record_pre_action 05:49:59 INFO - Running main action method: download_and_extract 05:49:59 INFO - mkdir: /builds/slave/test/build/tests 05:49:59 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')]} 05:49:59 INFO - https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:49:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/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 05:49:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/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 05:50:01 INFO - Downloaded 1361 bytes. 05:50:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:50:01 INFO - Using the following test package requirements: 05:50:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:50:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:01 INFO - u'jsshell-linux-x86_64.zip'], 05:50:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:50:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:50:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:01 INFO - https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/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 05:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/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 05:50:02 INFO - Downloaded 24308651 bytes. 05:50:02 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'] 05:50:02 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 05:50:04 INFO - Return code: 0 05:50:04 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 05:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:04 INFO - https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/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 05:50:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/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 05:50:17 INFO - Downloaded 24308651 bytes. 05:50:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:50:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:50:18 INFO - Return code: 0 05:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:18 INFO - https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:50:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/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 05:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/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 05:50:19 INFO - Downloaded 14403289 bytes. 05:50:19 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'] 05:50:19 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 05:50:19 INFO - Return code: 0 05:50: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')]} 05:50:19 INFO - https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:50:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/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 05:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/esexG4UrSJiYWCM6_cX-9w/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 05:50:21 INFO - Downloaded 60852540 bytes. 05:50:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:21 INFO - mkdir: /builds/slave/test/properties 05:50:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:50:21 INFO - Writing to file /builds/slave/test/properties/build_url 05:50:21 INFO - Contents: 05:50:21 INFO - build_url:https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:22 INFO - Running post-action listener: _resource_record_post_action 05:50:22 INFO - Running post-action listener: set_extra_try_arguments 05:50:22 INFO - [mozharness: 2016-07-24 12:50:22.352169Z] Finished download-and-extract step (success) 05:50:22 INFO - [mozharness: 2016-07-24 12:50:22.352278Z] Running populate-webroot step. 05:50:22 INFO - Running pre-action listener: _resource_record_pre_action 05:50:22 INFO - Running main action method: populate_webroot 05:50:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:22 INFO - '--tppagecycles', 05:50:22 INFO - '7'], 05:50:22 INFO - 'tests': ['tsvgm']}}, 05:50:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:50:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:50:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:50:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:22 INFO - 'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:22 INFO - 'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['damp', 'tps']}, 05:50:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:22 INFO - 'tests': ['damp', 'tps']}, 05:50:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['dromaeo_dom']}, 05:50:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['basic_compositor_video']}, 05:50:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:50:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['a11yr', 05:50:22 INFO - 'ts_paint', 05:50:22 INFO - 'tpaint', 05:50:22 INFO - 'sessionrestore', 05:50:22 INFO - 'sessionrestore_no_auto_restore', 05:50:22 INFO - 'tabpaint']}, 05:50:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:50:22 INFO - 'ts_paint', 05:50:22 INFO - 'tpaint', 05:50:22 INFO - 'sessionrestore', 05:50:22 INFO - 'sessionrestore_no_auto_restore', 05:50:22 INFO - 'tabpaint']}, 05:50:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:50:22 INFO - 'ts_paint', 05:50:22 INFO - 'tpaint', 05:50:22 INFO - 'sessionrestore', 05:50:22 INFO - 'sessionrestore_no_auto_restore', 05:50:22 INFO - 'tabpaint']}, 05:50:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:50:22 INFO - 'ts_paint', 05:50:22 INFO - 'tpaint', 05:50:22 INFO - 'sessionrestore', 05:50:22 INFO - 'sessionrestore_no_auto_restore', 05:50:22 INFO - 'tabpaint']}, 05:50:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['a11yr', 05:50:22 INFO - 'ts_paint', 05:50:22 INFO - 'tpaint', 05:50:22 INFO - 'sessionrestore', 05:50:22 INFO - 'sessionrestore_no_auto_restore', 05:50:22 INFO - 'tabpaint']}, 05:50:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['a11yr', 05:50:22 INFO - 'ts_paint', 05:50:22 INFO - 'tpaint', 05:50:22 INFO - 'sessionrestore', 05:50:22 INFO - 'sessionrestore_no_auto_restore', 05:50:22 INFO - 'tabpaint']}, 05:50:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['tsvgx', 05:50:22 INFO - 'tsvgr_opacity', 05:50:22 INFO - 'tart', 05:50:22 INFO - 'tscrollx', 05:50:22 INFO - 'cart']}, 05:50:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:50:22 INFO - 'tsvgr_opacity', 05:50:22 INFO - 'tart', 05:50:22 INFO - 'tscrollx', 05:50:22 INFO - 'cart']}, 05:50:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:22 INFO - 'talos_options': ['--disable-e10s'], 05:50:22 INFO - 'tests': ['tp5o']}, 05:50:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:22 INFO - 'tests': ['tp5o']}, 05:50:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:22 INFO - 'talos_options': ['--disable-e10s', 05:50:22 INFO - '--xperf_path', 05:50:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:22 INFO - 'tests': ['tp5n']}, 05:50:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:22 INFO - 'talos_options': ['--xperf_path', 05:50:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:22 INFO - 'tests': ['tp5n']}}, 05:50:22 INFO - 'talos.zip': {'path': '', 05:50:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:22 INFO - Running post-action listener: _resource_record_post_action 05:50:22 INFO - [mozharness: 2016-07-24 12:50:22.368753Z] Finished populate-webroot step (success) 05:50:22 INFO - [mozharness: 2016-07-24 12:50:22.368842Z] Running create-virtualenv step. 05:50:22 INFO - Running pre-action listener: _resource_record_pre_action 05:50:22 INFO - Running main action method: create_virtualenv 05:50:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:50:22 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 05:50:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:50:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:22 INFO - Using real prefix '/usr' 05:50:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:50:22 INFO - Installing distribute.............................................................................................................................................................................................done. 05:50:24 INFO - Installing pip.................done. 05:50:24 INFO - Return code: 0 05:50:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:24 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 0x2a06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc53b0>, '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 0x2cc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc6740>, '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': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', '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 05:50:24 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 05:50:24 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 05:50:24 INFO - Using env: {'DISPLAY': ':0', 05:50:24 INFO - 'HOME': '/home/cltbld', 05:50:24 INFO - 'LANG': 'en_US.UTF-8', 05:50:24 INFO - 'LANGUAGE': 'en_US:en', 05:50:24 INFO - 'LOGNAME': 'cltbld', 05:50:24 INFO - 'MAIL': '/var/mail/cltbld', 05:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:24 INFO - 'MOZ_NO_REMOTE': '1', 05:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:24 INFO - 'NO_EM_RESTART': '1', 05:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:24 INFO - 'PWD': '/builds/slave/test', 05:50:24 INFO - 'SHELL': '/bin/bash', 05:50:24 INFO - 'SHLVL': '1', 05:50:24 INFO - 'TERM': 'linux', 05:50:24 INFO - 'TMOUT': '86400', 05:50:24 INFO - 'USER': 'cltbld', 05:50:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', 05:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:24 INFO - '_': '/tools/buildbot/bin/python'} 05:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:25 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 05:50:25 INFO - Cleaning up... 05:50:25 INFO - Return code: 0 05:50:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:25 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 0x2a06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc53b0>, '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 0x2cc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc6740>, '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': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', '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 05:50:25 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 05:50:25 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 05:50:25 INFO - Using env: {'DISPLAY': ':0', 05:50:25 INFO - 'HOME': '/home/cltbld', 05:50:25 INFO - 'LANG': 'en_US.UTF-8', 05:50:25 INFO - 'LANGUAGE': 'en_US:en', 05:50:25 INFO - 'LOGNAME': 'cltbld', 05:50:25 INFO - 'MAIL': '/var/mail/cltbld', 05:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:25 INFO - 'MOZ_NO_REMOTE': '1', 05:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:25 INFO - 'NO_EM_RESTART': '1', 05:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:25 INFO - 'PWD': '/builds/slave/test', 05:50:25 INFO - 'SHELL': '/bin/bash', 05:50:25 INFO - 'SHLVL': '1', 05:50:25 INFO - 'TERM': 'linux', 05:50:25 INFO - 'TMOUT': '86400', 05:50:25 INFO - 'USER': 'cltbld', 05:50:25 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', 05:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:25 INFO - '_': '/tools/buildbot/bin/python'} 05:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:25 INFO - Downloading/unpacking psutil>=3.1.1 05:50:25 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 05:50:25 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 05:50:25 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 05:50:25 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 05:50:25 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 05:50:25 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 05:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:27 INFO - Installing collected packages: psutil 05:50:27 INFO - Running setup.py install for psutil 05:50:27 INFO - building 'psutil._psutil_linux' extension 05:50:27 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 05:50:27 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 05:50:27 INFO - building 'psutil._psutil_posix' extension 05:50:27 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 05:50:27 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 05:50:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:28 INFO - Successfully installed psutil 05:50:28 INFO - Cleaning up... 05:50:28 INFO - Return code: 0 05:50:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:28 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 0x2a06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc53b0>, '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 0x2cc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc6740>, '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': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', '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 05:50:28 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 05:50:28 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 05:50:28 INFO - Using env: {'DISPLAY': ':0', 05:50:28 INFO - 'HOME': '/home/cltbld', 05:50:28 INFO - 'LANG': 'en_US.UTF-8', 05:50:28 INFO - 'LANGUAGE': 'en_US:en', 05:50:28 INFO - 'LOGNAME': 'cltbld', 05:50:28 INFO - 'MAIL': '/var/mail/cltbld', 05:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:28 INFO - 'MOZ_NO_REMOTE': '1', 05:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:28 INFO - 'NO_EM_RESTART': '1', 05:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:28 INFO - 'PWD': '/builds/slave/test', 05:50:28 INFO - 'SHELL': '/bin/bash', 05:50:28 INFO - 'SHLVL': '1', 05:50:28 INFO - 'TERM': 'linux', 05:50:28 INFO - 'TMOUT': '86400', 05:50:28 INFO - 'USER': 'cltbld', 05:50:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', 05:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:28 INFO - '_': '/tools/buildbot/bin/python'} 05:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:50:29 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 05:50:29 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 05:50:29 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 05:50:29 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 05:50:29 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 05:50:29 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 05:50:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:50:31 INFO - Installing collected packages: mozsystemmonitor 05:50:31 INFO - Running setup.py install for mozsystemmonitor 05:50:31 INFO - Successfully installed mozsystemmonitor 05:50:31 INFO - Cleaning up... 05:50:31 INFO - Return code: 0 05:50:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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', '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 0x2a06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc53b0>, '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 0x2cc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc6740>, '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': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', '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 05:50: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:50: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 jsonschema==2.5.1 05:50:31 INFO - Using env: {'DISPLAY': ':0', 05:50:31 INFO - 'HOME': '/home/cltbld', 05:50:31 INFO - 'LANG': 'en_US.UTF-8', 05:50:31 INFO - 'LANGUAGE': 'en_US:en', 05:50:31 INFO - 'LOGNAME': 'cltbld', 05:50:31 INFO - 'MAIL': '/var/mail/cltbld', 05:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:31 INFO - 'MOZ_NO_REMOTE': '1', 05:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:31 INFO - 'NO_EM_RESTART': '1', 05:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:31 INFO - 'PWD': '/builds/slave/test', 05:50:31 INFO - 'SHELL': '/bin/bash', 05:50:31 INFO - 'SHLVL': '1', 05:50:31 INFO - 'TERM': 'linux', 05:50:31 INFO - 'TMOUT': '86400', 05:50:31 INFO - 'USER': 'cltbld', 05:50:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', 05:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:31 INFO - '_': '/tools/buildbot/bin/python'} 05:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:31 INFO - Downloading/unpacking jsonschema==2.5.1 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:50:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:50:33 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 05:50:33 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 05:50:33 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 05:50:33 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 05:50:33 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 05:50:33 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 05:50:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:50:33 INFO - warning: no files found matching '*.txt' 05:50:33 INFO - no previously-included directories found matching 'build' 05:50:33 INFO - no previously-included directories found matching 'dist' 05:50:33 INFO - no previously-included directories found matching '.git*' 05:50:33 INFO - Installing collected packages: jsonschema, functools32 05:50:33 INFO - Running setup.py install for functools32 05:50:33 INFO - warning: no files found matching '*.txt' 05:50:33 INFO - no previously-included directories found matching 'build' 05:50:33 INFO - no previously-included directories found matching 'dist' 05:50:33 INFO - no previously-included directories found matching '.git*' 05:50:33 INFO - Successfully installed jsonschema functools32 05:50:33 INFO - Cleaning up... 05:50:33 INFO - Return code: 0 05:50:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:33 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 0x2a06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc53b0>, '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 0x2cc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc6740>, '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': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', '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 05:50:33 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 05:50:33 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 05:50:33 INFO - Using env: {'DISPLAY': ':0', 05:50:33 INFO - 'HOME': '/home/cltbld', 05:50:33 INFO - 'LANG': 'en_US.UTF-8', 05:50:33 INFO - 'LANGUAGE': 'en_US:en', 05:50:33 INFO - 'LOGNAME': 'cltbld', 05:50:33 INFO - 'MAIL': '/var/mail/cltbld', 05:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:33 INFO - 'MOZ_NO_REMOTE': '1', 05:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:33 INFO - 'NO_EM_RESTART': '1', 05:50:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:33 INFO - 'PWD': '/builds/slave/test', 05:50:33 INFO - 'SHELL': '/bin/bash', 05:50:33 INFO - 'SHLVL': '1', 05:50:33 INFO - 'TERM': 'linux', 05:50:33 INFO - 'TMOUT': '86400', 05:50:33 INFO - 'USER': 'cltbld', 05:50:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', 05:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:33 INFO - '_': '/tools/buildbot/bin/python'} 05:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:33 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 05:50:33 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 05:50:33 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 05:50:33 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 05:50:33 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 05:50:33 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 05:50:35 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:50:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50:36 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 05:50:36 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 05:50:36 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 05:50:36 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 05:50:36 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 05:50:36 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 05:50:36 INFO - Downloading docopt-0.6.1.tar.gz 05:50:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:50:36 INFO - Installing collected packages: blobuploader, requests, docopt 05:50:36 INFO - Running setup.py install for blobuploader 05:50:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:50:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:50:36 INFO - Running setup.py install for requests 05:50:37 INFO - Running setup.py install for docopt 05:50:37 INFO - Successfully installed blobuploader requests docopt 05:50:37 INFO - Cleaning up... 05:50:37 INFO - Return code: 0 05:50:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:37 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 0x2a06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc53b0>, '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 0x2cc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc6740>, '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': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', '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 05:50:37 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 05:50:37 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 05:50:37 INFO - Using env: {'DISPLAY': ':0', 05:50:37 INFO - 'HOME': '/home/cltbld', 05:50:37 INFO - 'LANG': 'en_US.UTF-8', 05:50:37 INFO - 'LANGUAGE': 'en_US:en', 05:50:37 INFO - 'LOGNAME': 'cltbld', 05:50:37 INFO - 'MAIL': '/var/mail/cltbld', 05:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:37 INFO - 'MOZ_NO_REMOTE': '1', 05:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:37 INFO - 'NO_EM_RESTART': '1', 05:50:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:37 INFO - 'PWD': '/builds/slave/test', 05:50:37 INFO - 'SHELL': '/bin/bash', 05:50:37 INFO - 'SHLVL': '1', 05:50:37 INFO - 'TERM': 'linux', 05:50:37 INFO - 'TMOUT': '86400', 05:50:37 INFO - 'USER': 'cltbld', 05:50:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', 05:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:37 INFO - '_': '/tools/buildbot/bin/python'} 05:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:37 INFO - Running setup.py (path:/tmp/pip-cTEEYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:37 INFO - Running setup.py (path:/tmp/pip-JFNPag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:37 INFO - Running setup.py (path:/tmp/pip-_Yf6tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:37 INFO - Running setup.py (path:/tmp/pip-7rQuW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:37 INFO - Running setup.py (path:/tmp/pip-4Rof1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:37 INFO - Running setup.py (path:/tmp/pip-ITKQl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:37 INFO - Running setup.py (path:/tmp/pip-KG5Ken-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:37 INFO - Running setup.py (path:/tmp/pip-UT3Qob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:38 INFO - Running setup.py (path:/tmp/pip-GAF4wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:38 INFO - Running setup.py (path:/tmp/pip-5U0rbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:38 INFO - Running setup.py (path:/tmp/pip-bGUPPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:38 INFO - Running setup.py (path:/tmp/pip-ehKkn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:38 INFO - Running setup.py (path:/tmp/pip-UqdTYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:38 INFO - Running setup.py (path:/tmp/pip-Qs4bfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:38 INFO - Running setup.py (path:/tmp/pip-fTwlkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:38 INFO - Running setup.py (path:/tmp/pip-pcWaBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:38 INFO - Running setup.py (path:/tmp/pip-hyqlAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:38 INFO - Running setup.py install for manifestparser 05:50:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:50:38 INFO - Running setup.py install for mozcrash 05:50:38 INFO - Running setup.py install for mozdebug 05:50:38 INFO - Running setup.py install for mozdevice 05:50:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:50:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:50:39 INFO - Running setup.py install for mozfile 05:50:39 INFO - Running setup.py install for mozhttpd 05:50:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:50:39 INFO - Running setup.py install for mozinfo 05:50:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:50:39 INFO - Running setup.py install for mozInstall 05:50:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:50:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:50:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:50:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:50:39 INFO - Running setup.py install for mozleak 05:50:39 INFO - Running setup.py install for mozlog 05:50:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:50:39 INFO - Running setup.py install for moznetwork 05:50:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:50:39 INFO - Running setup.py install for mozprocess 05:50:39 INFO - Running setup.py install for mozprofile 05:50:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Running setup.py install for mozrunner 05:50:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Running setup.py install for mozscreenshot 05:50:40 INFO - Running setup.py install for moztest 05:50:40 INFO - Running setup.py install for mozversion 05:50:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:50:40 INFO - Cleaning up... 05:50:40 INFO - Return code: 0 05:50:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:40 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 0x2a06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc53b0>, '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 0x2cc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc6740>, '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': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', '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 05:50:40 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 05:50:40 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 05:50:40 INFO - Using env: {'DISPLAY': ':0', 05:50:40 INFO - 'HOME': '/home/cltbld', 05:50:40 INFO - 'LANG': 'en_US.UTF-8', 05:50:40 INFO - 'LANGUAGE': 'en_US:en', 05:50:40 INFO - 'LOGNAME': 'cltbld', 05:50:40 INFO - 'MAIL': '/var/mail/cltbld', 05:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:40 INFO - 'MOZ_NO_REMOTE': '1', 05:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:40 INFO - 'NO_EM_RESTART': '1', 05:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:40 INFO - 'PWD': '/builds/slave/test', 05:50:40 INFO - 'SHELL': '/bin/bash', 05:50:40 INFO - 'SHLVL': '1', 05:50:40 INFO - 'TERM': 'linux', 05:50:40 INFO - 'TMOUT': '86400', 05:50:40 INFO - 'USER': 'cltbld', 05:50:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', 05:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:40 INFO - '_': '/tools/buildbot/bin/python'} 05:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:40 INFO - Running setup.py (path:/tmp/pip-A0HsMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:40 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)) 05:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:40 INFO - Running setup.py (path:/tmp/pip-Jpriaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:40 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)) 05:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:40 INFO - Running setup.py (path:/tmp/pip-0CvajT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:40 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)) 05:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:40 INFO - Running setup.py (path:/tmp/pip-KqUx7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:40 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)) 05:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:40 INFO - Running setup.py (path:/tmp/pip-zWPemY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:41 INFO - Running setup.py (path:/tmp/pip-YKZs2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:41 INFO - Running setup.py (path:/tmp/pip-ReC2Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:41 INFO - Running setup.py (path:/tmp/pip-AvR_nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:41 INFO - Running setup.py (path:/tmp/pip-wFJ8Dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:41 INFO - Running setup.py (path:/tmp/pip-2pocBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:41 INFO - Running setup.py (path:/tmp/pip-A1xIMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:41 INFO - Running setup.py (path:/tmp/pip-geSa14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:41 INFO - Running setup.py (path:/tmp/pip-Zsns8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:41 INFO - Running setup.py (path:/tmp/pip-pEzAAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:41 INFO - Running setup.py (path:/tmp/pip-DJYB3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:41 INFO - Running setup.py (path:/tmp/pip-T94rpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:41 INFO - Running setup.py (path:/tmp/pip-Lvjgxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:41 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)) 05:50:41 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)) 05:50:41 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)) 05:50:41 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)) 05:50:41 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)) 05:50:41 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)) 05:50:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:41 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 05:50:41 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 05:50:41 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 05:50:41 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 05:50:41 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 05:50:41 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 05:50:43 INFO - Downloading blessings-1.6.tar.gz 05:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:50:43 INFO - Installing collected packages: blessings 05:50:43 INFO - Running setup.py install for blessings 05:50:44 INFO - Successfully installed blessings 05:50:44 INFO - Cleaning up... 05:50:44 INFO - Return code: 0 05:50:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:50:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:44 INFO - Reading from file tmpfile_stdout 05:50:44 INFO - Current package versions: 05:50:44 INFO - argparse == 1.2.1 05:50:44 INFO - blessings == 1.6 05:50:44 INFO - blobuploader == 1.2.4 05:50:44 INFO - docopt == 0.6.1 05:50:44 INFO - functools32 == 3.2.3-2 05:50:44 INFO - jsonschema == 2.5.1 05:50:44 INFO - manifestparser == 1.1 05:50:44 INFO - mozInstall == 1.12 05:50:44 INFO - mozcrash == 0.17 05:50:44 INFO - mozdebug == 0.1 05:50:44 INFO - mozdevice == 0.48 05:50:44 INFO - mozfile == 1.2 05:50:44 INFO - mozhttpd == 0.7 05:50:44 INFO - mozinfo == 0.9 05:50:44 INFO - mozleak == 0.1 05:50:44 INFO - mozlog == 3.3 05:50:44 INFO - moznetwork == 0.27 05:50:44 INFO - mozprocess == 0.23 05:50:44 INFO - mozprofile == 0.28 05:50:44 INFO - mozrunner == 6.12 05:50:44 INFO - mozscreenshot == 0.1 05:50:44 INFO - mozsystemmonitor == 0.3 05:50:44 INFO - moztest == 0.7 05:50:44 INFO - mozversion == 1.4 05:50:44 INFO - psutil == 3.1.1 05:50:44 INFO - requests == 1.2.3 05:50:44 INFO - wsgiref == 0.1.2 05:50:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:44 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 0x2a06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc53b0>, '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 0x2cc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc6740>, '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': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', '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 05:50:44 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 05:50:44 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 05:50:44 INFO - Using env: {'DISPLAY': ':0', 05:50:44 INFO - 'HOME': '/home/cltbld', 05:50:44 INFO - 'LANG': 'en_US.UTF-8', 05:50:44 INFO - 'LANGUAGE': 'en_US:en', 05:50:44 INFO - 'LOGNAME': 'cltbld', 05:50:44 INFO - 'MAIL': '/var/mail/cltbld', 05:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:44 INFO - 'MOZ_NO_REMOTE': '1', 05:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:44 INFO - 'NO_EM_RESTART': '1', 05:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:44 INFO - 'PWD': '/builds/slave/test', 05:50:44 INFO - 'SHELL': '/bin/bash', 05:50:44 INFO - 'SHLVL': '1', 05:50:44 INFO - 'TERM': 'linux', 05:50:44 INFO - 'TMOUT': '86400', 05:50:44 INFO - 'USER': 'cltbld', 05:50:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', 05:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:44 INFO - '_': '/tools/buildbot/bin/python'} 05:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:44 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)) 05:50:44 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)) 05:50:44 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)) 05:50:44 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)) 05:50:44 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)) 05:50:44 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)) 05:50:44 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)) 05:50:44 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)) 05:50:44 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)) 05:50:44 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)) 05:50:44 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)) 05:50:44 INFO - Cleaning up... 05:50:44 INFO - Return code: 0 05:50:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc53b0>, '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 0x2cc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc6740>, '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': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', '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 05:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:50:44 INFO - Using env: {'DISPLAY': ':0', 05:50:44 INFO - 'HOME': '/home/cltbld', 05:50:44 INFO - 'LANG': 'en_US.UTF-8', 05:50:44 INFO - 'LANGUAGE': 'en_US:en', 05:50:44 INFO - 'LOGNAME': 'cltbld', 05:50:44 INFO - 'MAIL': '/var/mail/cltbld', 05:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:44 INFO - 'MOZ_NO_REMOTE': '1', 05:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:44 INFO - 'NO_EM_RESTART': '1', 05:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:44 INFO - 'PWD': '/builds/slave/test', 05:50:44 INFO - 'SHELL': '/bin/bash', 05:50:44 INFO - 'SHLVL': '1', 05:50:44 INFO - 'TERM': 'linux', 05:50:44 INFO - 'TMOUT': '86400', 05:50:44 INFO - 'USER': 'cltbld', 05:50:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', 05:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:44 INFO - '_': '/tools/buildbot/bin/python'} 05:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:50:44 INFO - Cleaning up... 05:50:44 INFO - Return code: 0 05:50:44 INFO - Running post-action listener: _resource_record_post_action 05:50:44 INFO - Running post-action listener: _start_resource_monitoring 05:50:44 INFO - Starting resource monitoring. 05:50:44 INFO - [mozharness: 2016-07-24 12:50:44.768710Z] Finished create-virtualenv step (success) 05:50:44 INFO - [mozharness: 2016-07-24 12:50:44.769193Z] Running install step. 05:50:44 INFO - Running pre-action listener: _resource_record_pre_action 05:50:44 INFO - Running main action method: install 05:50:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:44 INFO - Reading from file tmpfile_stdout 05:50:44 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:50:45 INFO - Reading from file tmpfile_stdout 05:50:45 INFO - Output received: 05:50:45 INFO - Usage: mozinstall [options] installer 05:50:45 INFO - Options: 05:50:45 INFO - -h, --help show this help message and exit 05:50:45 INFO - -d DEST, --destination=DEST 05:50:45 INFO - Directory to install application into. [default: 05:50:45 INFO - "/builds/slave/test"] 05:50:45 INFO - --app=APP Application being installed. [default: firefox] 05:50:45 INFO - mkdir: /builds/slave/test/build/application 05:50:45 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'] 05:50:45 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 05:51:02 INFO - Reading from file tmpfile_stdout 05:51:02 INFO - Output received: 05:51:02 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:02 INFO - Running post-action listener: _resource_record_post_action 05:51:02 INFO - [mozharness: 2016-07-24 12:51:02.263627Z] Finished install step (success) 05:51:02 INFO - [mozharness: 2016-07-24 12:51:02.263907Z] Running run-tests step. 05:51:02 INFO - Running pre-action listener: _resource_record_pre_action 05:51:02 INFO - Running main action method: run_tests 05:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:02 INFO - Python 2.7.3 05:51:02 INFO - Return code: 0 05:51:02 INFO - grabbing minidump binary from tooltool 05:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc53b0>, '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 0x2cc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:51:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:51:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:51:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:02 INFO - Return code: 0 05:51:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 05:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 05:51:02 INFO - Using env: {'DISPLAY': ':0', 05:51:02 INFO - 'HOME': '/home/cltbld', 05:51:02 INFO - 'LANG': 'en_US.UTF-8', 05:51:02 INFO - 'LANGUAGE': 'en_US:en', 05:51:02 INFO - 'LOGNAME': 'cltbld', 05:51:02 INFO - 'MAIL': '/var/mail/cltbld', 05:51:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:02 INFO - 'MOZ_NO_REMOTE': '1', 05:51:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:02 INFO - 'NO_EM_RESTART': '1', 05:51:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:02 INFO - 'PWD': '/builds/slave/test', 05:51:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:02 INFO - 'SHELL': '/bin/bash', 05:51:02 INFO - 'SHLVL': '1', 05:51:02 INFO - 'TERM': 'linux', 05:51:02 INFO - 'TMOUT': '86400', 05:51:02 INFO - 'USER': 'cltbld', 05:51:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474', 05:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:02 INFO - '_': '/tools/buildbot/bin/python'} 05:51:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 05:51:02 INFO - mozversion application_buildid: 20160724030208 05:51:02 INFO - mozversion application_changeset: e0bc88708ffed39aaab1fbc0ac461d93561195de 05:51:02 INFO - mozversion application_display_name: Nightly 05:51:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:02 INFO - mozversion application_name: Firefox 05:51:02 INFO - mozversion application_remotingname: firefox 05:51:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:51:02 INFO - mozversion application_vendor: Mozilla 05:51:02 INFO - mozversion application_version: 50.0a1 05:51:02 INFO - mozversion platform_buildid: 20160724030208 05:51:02 INFO - mozversion platform_changeset: e0bc88708ffed39aaab1fbc0ac461d93561195de 05:51:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:51:02 INFO - mozversion platform_version: 50.0a1 05:51:02 INFO - using testdate: 1469364662 05:51:02 INFO - actual date: 1469364662 05:51:02 INFO - starting webserver on 'localhost:34936' 05:51:02 INFO - SUITE-START | Running 2 tests 05:51:02 INFO - TEST-START | dromaeo_css 05:51:02 INFO - operating with platform_type : linux_ 05:51:02 INFO - Initialising browser for dromaeo_css test... 05:51:02 INFO - TEST-INFO | started process 10921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ylwo3/profile http://localhost:34936/getInfo.html) 05:51:06 INFO - PROCESS | 10921 | JavaScript error: , line 0: uncaught exception: undefined 05:51:07 INFO - PROCESS | 10921 | __metrics Screen width/height:1600/1200 05:51:07 INFO - PROCESS | 10921 | colorDepth:24 05:51:07 INFO - PROCESS | 10921 | Browser inner width/height: 1024/697 05:51:07 INFO - PROCESS | 10921 | __metrics 05:51:07 INFO - PROCESS | 10921 | 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" 05:51:07 INFO - PROCESS | 10921 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:08 INFO - TEST-INFO | 10921: exit 0 05:51:08 INFO - Browser initialized. 05:51:08 INFO - Running cycle 1/1 for dromaeo_css test... 05:51:08 INFO - TEST-INFO | started process 11003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ylwo3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:20 INFO - PROCESS | 11003 | RSS: Main: 157769728 05:51:20 INFO - PROCESS | 11003 | 05:52:12 INFO - PROCESS | 11003 | 1469364732088 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] 05:54:19 INFO - PROCESS | 11003 | Cycle 1(1): loaded http://localhost:34936/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34936/tests/dromaeo/cssquery-ext.html) 05:54:20 INFO - PROCESS | 11003 | RSS: Main: 255299584 05:54:20 INFO - PROCESS | 11003 | 05:57:23 INFO - PROCESS | 11003 | Cycle 1(1): loaded http://localhost:34936/tests/dromaeo/cssquery-ext.html (next: http://localhost:34936/tests/dromaeo/cssquery-jquery.html) 05:57:23 INFO - PROCESS | 11003 | RSS: Main: 241479680 05:57:23 INFO - PROCESS | 11003 | 06:00:25 INFO - PROCESS | 11003 | Cycle 1(1): loaded http://localhost:34936/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34936/tests/dromaeo/cssquery-mootools.html) 06:00:26 INFO - PROCESS | 11003 | RSS: Main: 184868864 06:00:26 INFO - PROCESS | 11003 | 06:03:28 INFO - PROCESS | 11003 | Cycle 1(1): loaded http://localhost:34936/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34936/tests/dromaeo/cssquery-prototype.html) 06:03:29 INFO - PROCESS | 11003 | RSS: Main: 233439232 06:03:29 INFO - PROCESS | 11003 | 06:06:31 INFO - PROCESS | 11003 | Cycle 1(1): loaded http://localhost:34936/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34936/tests/dromaeo/cssquery-yui.html) 06:06:32 INFO - PROCESS | 11003 | RSS: Main: 187342848 06:06:32 INFO - PROCESS | 11003 | 06:09:35 INFO - PROCESS | 11003 | Cycle 1(1): loaded http://localhost:34936/tests/dromaeo/cssquery-yui.html (next: http://localhost:34936/tests/dromaeo/cssquery-dojo.html) 06:09:35 INFO - PROCESS | 11003 | RSS: Main: 270254080 06:09:35 INFO - PROCESS | 11003 | 06:09:35 INFO - PROCESS | 11003 | __start_tp_report 06:09:35 INFO - PROCESS | 11003 | _x_x_mozilla_page_load 06:09:35 INFO - PROCESS | 11003 | _x_x_mozilla_page_load_details 06:09:35 INFO - PROCESS | 11003 | |i|pagename|runs| 06:09:35 INFO - PROCESS | 11003 | |0;dojo.html;3079.9076027719166;3084.1056093732805;3103.069079276217;3124.343887783565;3151.023182813328;5148.150555158394;5219.112750832358;5325.4142044375085;5410.702411367373;5439.238506609078;5219.45195754446;5278.3665960084745;5304.522592966632;5346.251524786533;5378.677279363241;4740.739259340744;4771.141194584973;4818.71087734737;4823.276508523714;4992.375953005874;4919.13915064864;4932.827351042714;4945.381827271591;4947.851564453073;4968.478309777475;4750.477447480775;4790.496997815214;4895.55939965403;4950.133726597867;4951.950480495203;4743.075100355432;4785.353977213066;4791.6406269529925;4845.176320025604;4854.344663470457;4822.180229361017;4826.420829500447;4840.636952228597;4883.267509873512;4914.533119353656;5223.477652234784;5404.4595540446035;5407.242985981966;5423.620346575742;5443.401225865152;5519.227308176858;5579.609427340088;5581.441855814427;5595.412481689405;5643.097104463307;5632.690202038886;5642.266505354278;5680.11958146488;5698.202251684767;5700.37295897451;5102.260172275037;5277.129273669878;5313.415524292324;5315.202719592015;5333.759980800874;5831.096180092092;5883;5888.293404791367;5933.881322373529;5944.286685597669;5645.576581756384;5649.237352957298;5684.54523638108;5692.829215123553;5696.202531645573;5395.973020134953;5587.74855131512;5687.40282270364;5747.827565173052;5755.366909639936;5626.774929002876;5642.181883626851;5647.576431767634;5696.772129114872;5700.8859822803315;5622.634528755618;5646.2942132233475;5652.802151924663;5655.632383895034;5657.632253903483;4225.176090662353;4308.332208507686;4375.343698445258;4375.890602734893;4423.093265880487;3837.6354246346555;3866.709996750255;3889.7277190596387;3952.565217826037;3967.127232009011;5370.516653501204;5377.381601115843;5378.489043540857;5382.623216374895;5383.703896285742;5653.802116925888;5668.744906479218;5672.290963629546;5707.3721890592005;5725.055365864586;5250.579953603703;5385.299911011543;5411.269478620336;5439.945600543944;5511.173324001352;4975.4527002029745;4982.551570358685;4983.775730092155;4987.80048798044;5031.169856973558;5911.822645320647;5949.791757288474;5967.6419414835245;5968.492678122321;5976.043832986701;5473.343198816167;5612.85967850807;5656.8020119295625;5657.405972373006;5730.74211660468;5861.1501332305725;5879.529637629065;5887.764489420375;5888;5895.145203945318;5484.341878974548;5530.861728456821;5533.335999680065;5536.667799932017;5567.2762540871045;5544.390117087037;5697.686627235376;5711.7429715662065;5751.74117164737;5841.707914604338;5657.8019769307875;5659.943400566106;5661.320641523043;5661.348944871228;5663.5469162467725;5585.994520986099;5624.521915637217;5649.68926709035;5657.60396772222;5664.26364572603;5313.495217954288;5423.701696406735;5456.809011684572;5481.643693159932;5548.500634942875;5586.608937374344;5587.385387607441;5636.802711905064;5651.660900345828;5652.85867853307;5469.945300546943;5475.397706252229;5477.452254774491;5480.3971563128825;5482.945170548243 06:09:35 INFO - PROCESS | 11003 | |1;ext.html;602.801075645037;602.8643555200081;631.4159402552639;645.2450632759668;663.8705452436777;30737.385252294967;42913;44305.7784711076;44330.33504497427;44388.77805610967;44600.330995035016;44949.7752511237;45082.54917450825;45204.773976130076;45249.321260181125;8025.197480251986;8910.688125915578;9061.184493395593;9066.546672666373;10445.26883118182;10329.276950613461;10773.515191816348;10782.892171078307;10797.190210734187;10811.621593244237;10904.672859814218;10958.506867190996;10958.726031849188;10967.451627418637;10978.12175026;8025.478343907627;10789.568417263301;10835.566577336896;10863.29388589743;11128.38793866337;10648;10714.624988125379;10718.571257149704;10722.356658600509;10723.249372543925;42489.57510424918;42849.35725964113;42984.78507607442;43066.35400468996;43103.78448107771;3474.409350410436;3676.8529258829612;3764.1154328733;3764.5858955515146;4237.788110594489;32041.359172816647;32644.347113057844;32739.6726032739;32792.5081123781;32818.17954551132;4376.3654270130655;4419.4254746883025;4421.60205581496;4432.645388368923;4450.132224216279;343425;346241;346785;346973;346987;56810.431895680515;57485.71257143771;57606;57606.7119664399;57638.13542796861;60077.69961150167;60168.39831601628;60207;60257;60307.396926031055;14992.325345359484;15187.696246075238;15188.848111518964;15199;15207.08757474555;10367.63713270032;10512.106470949902;10634.30876992993;10727;11512.194146409838;16603.169841507875;16624.418145364853;16629.584260393345;16636.916815415847;16696.74954875678;5783.681897495594;5906.704664766745;5971.7611295547695;6001.819945401645;6115.847103822351;792.2869417524274;853.2022558907441;895.9910400895908;937.9718608441758;1035.089121573011;31232.438378081006;31933.680663193536;32031.51952720711;32143.51784723231;32314.83842580819;1060.9363438193734;1089.8937578357973;1097.8902109789117;1137.1869113583828;1202.9759404811855;16409.42567010149;17113.743293850603;17124.914375428045;17222.91388543049;17235;496873;500710;501429;502625;503998;56259.43740562542;56352.71823640855;56492.717536412056;56591.71704141535;56600;1198.5924785572947;1304.6868751499571;1323.1928523600595;1339.1028011232304;1340.3432318164225;30441.695583043886;31746;32223.67776322207;32323.838380807945;32951.835240823646;50400.49599503958;51229.48770512247;51293.487065130364;51439.22841157311;51503.227451589;410045;414953;415737;418430;418957;26485.602715958892;27013.59479607847;27154.592681109403;28519.572206416506;28677.426451470437;47638.28542571795;47761.5223847771;48238.970128733905;48524.757376212896;48726.26910596273;39874;40571;41731.7913410431;41838.58161418469;42612.360814587184;40584.59415405808;40660.79669601633;41592.58407415887;42369.36445953252;42770.78614606907;38027.61972380241;39117.80441097776;40181.598184018956;40250.19499609933;42359.7882010588;32806.83596582002;36657.816710916275;36976;37718.2456350877;37941;27488.58767118535;27936.720632794226;28128.85935570309;28135.296617584725;28148.71851281461 06:09:35 INFO - PROCESS | 11003 | |2;jquery.html;371.1500663480629;392.2351414741255;394.3453866581475;397.83688687638073;412.83486605357854;14133.646658833535;17096.57258568535;19271.22915083395;19561.90219048906;19569.315073972397;18822.71765923512;18856.34002809902;19003.239870405203;19007.429777106674;19188.136533855974;4025.7987100644996;5515.420880807507;5693.487586117249;5695.231143795576;5722.656640601556;5352.197170424429;6334.271558770732;6414.711337989802;6465.09488671584;6477.514186436013;6124.540659450537;6271.749130034793;6275.811725648215;6449.774257900975;6453.548251622388;6315.242170939494;6333.651649159295;6345.175127233453;6346.397092276226;6352.872942541147;5411.485908838654;5558.583106267006;5603.3836278009385;5605.159226116115;5617.41017193197;22830.200942967083;23049;23451.53096938069;23458.06167753305;23574.76425235743;2257.4694946687514;2261.3894248552797;2304.5045315257134;2359.0799588160457;2382.1543352109925;13878.167309961435;14221.360038798279;14281.500147494788;14314.498992535211;14742.41030358795;1964.7052942058806;1965.8525610579263;2019.7374341335678;2022.6157030164368;2069.3274685727047;77722;78224.60887695524;78830.6058469704;79117.20882791156;79319.20680793175;10120.240981926385;10285.897141028643;10506.947465262625;10586.04725574702;10729.892701073046;14816.629584260265;14856.702865942621;14863.108213507225;14888.032277901902;14891.627709307353;7606.23937606246;7824.37405007598;7863.13505514393;8011.278984891388;8169.5098294102545;7489.251074892576;7493.88759168602;7534.736284230025;7755.72854950074;7849.254320839511;6430;6574;6666.666666666647;6681.864083105884;6760.966195168992;1830.5606654403114;1871.2608519634668;1874.400191938594;1880.125741530195;1930.4401723500027;1007.778288776468;1030.99484502577;1035.3684252605904;1064.7148545054733;1094.5676457799125;19146.425607231806;19493.415197544095;19546.413607591796;19718.90140549317;20060.197592096152;1004.7186787699455;1012.2408193854609;1015.7105225010837;1036.7667274863095;1059.3643813711865;10380.83384567699;11102.944485277683;11218.270812397332;11222.943885280521;11302;457570;460238;481226;491477;493823;48713;57436.71281643565;66496.33503664902;66951.33048669451;80156;964.5129209749032;975.6829030565095;998.2164001259122;1019.8521214423866;1030.525958059286;16084.35662573484;16250.918745406198;16548.669026619158;17187.82812171912;17797.199126039617;40283.17309855559;41477.58522414737;41636.58363416327;43509;44390.3341449872;52695.73652131715;54098.45901540934;54540.454595453535;55800.441995581146;56206;7077.504574679723;7993.6802527898235;8025.59872006409;8031.799205019921;8187.222213889671;10581.682549523526;12595.370231488205;12918.870811291767;12964.707406909025;13231.933840331121;10622.309549879234;10636.255462117577;11130.777384452427;11337.093032557541;11389.886101139215;10986.670399888017;11059.668209953714;11131.341471908027;11222.943885280521;11254.099672026383;10649.8935010652;10854.891451085388;11193.440327983406;11204.271722338022;11480.82778758336;7204.3155900189395;7311.341979221896;7356.852862942604;7424.814379640552;7504.3246107850555;9427.528623568931;10511.526981286013;10648.787024259627;10705.89294107049;11004.614838480615 06:09:35 INFO - PROCESS | 11003 | |3;mootools.html;1339.5847287340926;1445.8409574946754;1485.2128371962856;1708.2995971651626;1771.0878897367859;8302.460340077898;8787.560621968907;8806.383553151281;8817.338699597523;8822.735317940473;7318.560886346823;8125.106238313796;8333.541655208961;8346.499210047401;8655.87016194756;2288.141946769965;2316.6177580699164;2317.316391664463;2317.9072837086496;2321.036769740564;2287.736910255317;2291.186628746796;2334.206369834256;2341.718993720747;2350.095213342867;1884.7832499262622;2160.2439146298825;2196.6265734825038;2218.4897473581086;2234.6089434348924;2258.8531745436494;2259.378670865517;2274.704288442492;2284.805791507724;2285.4743409015937;2247.404437823978;2255.357223191399;2262.502249505106;2263.0608297556496;2265.2071774878827;8532.957335213347;8559.700410485666;8567.186117318906;8571.442856214326;8571.528565928871;4918.114739346916;5084.79660813567;5085.974570127126;5093.1087059764395;5094.541491265803;3090.6909309069138;3164.9208769780707;3304.140923359944;3309.0569187781366;3322;1056.281728424671;1062.941538215398;1085.1535802074395;1088.4720910358549;1099.0932480703373;11836.644900652995;11914.821277680756;11920.046396288362;11920.701982450508;11924.284542927366;4236.301010333322;4406.383106365111;4418.779061046999;4560.977195114069;4563.863084107482;10043.849342259726;10048.447335396624;10049.145822605014;10050.09549140581;10050.346727462691;5049.2426136079885;5065.696058236444;5096.770645320969;5105.821296254613;5114.28400023997;4661.883452913704;4719.315699223594;4732.787024583902;4732.858014259577;4757.500462451393;3852.0947577319307;3874.651281384689;3901.765894046366;3938.0942383252013;3965.1871366369824;1209.8245754365569;1213.235661533246;1218.165556593736;1224.9176400119832;1229.7847876621556;737.5611511150856;883.7216276872764;903.5527413930015;959.4627008875052;1012.6658202793061;5710.400407957188;5832.12518122285;5904.586678932519;5987.1318658794235;6124.663143527148;987.4124895687055;988.5057471264367;1000.2048371544639;1001.9198464122853;1045.8431235314763;3922.9215415692097;4279.33670281107;4295.591918767712;4299.892502687458;4408.360787685768;10294.279400442047;10605.204609654307;10611.41637209961;10636.521356538975;10714.821369649333;10517.21120915919;10543.42011189392;10595.682129535971;10600.946995265129;10673.679789606324;7926.801829954297;7948.165442628557;7952.880706789403;8011.319037881729;8021.2379823916635;5739.339975902658;5762.1644861494015;5879.764809407576;5896.439838215363;6014.007688731311;9777.16894063984;9804.460754658563;9855.408675479493;9928.652497162564;9964.850527242243;9944.850827237742;10110.140638045848;10126;10147.086762191439;10158.08577228053;7586.127595326608;7622.847543048997;7623;7626.084869815658;7659.080910290801;7948.602569871599;7969.641366138653;8102.270795628186;8228.21831925966;8276.337892968668;5689.800856969986;7315.158756743042;7385.224551422239;7398.371138453292;7401.59291238987;7193.71225151009;7209.3872020876715;7256.963715181601;7279.818004549928;7345.926540734525;6727.058211850443;6833.5899846007405;6841.3842754152365;6842.178938527409;6848.417884479875;5271.973640131928;5299.125644268806;5349.090654588807;5394.32570928634;5536.141898005815;5337.412884582771;5370.167624018283;5394.514493695587;5445.292112025411;5474.91787623194 06:09:35 INFO - PROCESS | 11003 | |4;prototype.html;315.35195173917595;316.16847690573786;323.3274788440045;323.6957260175435;332.41660885146564;5279.498447647472;5318.707471089088;5324.813631522898;5330.440303768107;5368.8389348319515;4969.155243608586;5085.084684756743;5093.9235911461265;5113.872153196163;5256.421793602701;3995.1011022519992;4041.4544036555058;4086.16233672098;4116.75299482032;4117.423560701504;4084.856240252719;4095.344744840826;4101.302778527657;4108.424820525129;4140.5859414058505;3939.901502462447;4076.653484453825;4084.4894388201474;4100.323446631302;4109.191955539553;4076.8776936691797;4086.5709100544314;4099.077707515785;4102.589741025873;4104.712670113093;3618.981905090484;3630.2739452109686;3639.5796795131205;3650.4159334506353;3652.7808331500196;4870.391201099863;5141.383034035902;5175.430702622709;5175.844724658266;5187.922181167285;4671.672982891199;4707.5763181313505;4713.316569097496;4736.431628204603;4747.8575642730775;5507.779688812443;5513.2908798272665;5515.696636684981;5528;5546.251256080418;3865.40086286626;3997.7407116758127;4003.1793482336343;4004.2191772604356;4026.6577340926056;5683.5737319700775;5686.289213848269;5698.886022279573;5716.742746576372;5718.941995730803;4052.797360131982;4054.6350828425584;4054.8378064877666;4069.267531844237;4075.65356944663;4100.897477563085;4119.629233369011;4123.299039163349;4128.876133715933;4134;4519.186546421675;4642.025174713281;4693.95306046942;4700.764961751899;4743.549362810528;5453.454654534515;5517.641353312022;5520.199571062173;5528.75120619573;5536.612437129443;1365.4742923974143;1400.7268582626493;1408.0284603623468;1414.1797757300742;1425.5794540610545;973.7808992976666;992.533509250651;1000.5997600959674;1001.9779824578889;1005.4972513743129;5333.919991200135;5339;5346.599005074635;5361.946380536223;5372.892542149135;5471.206675032098;5596.888062238732;5614;5647.37878833328;5656.717164141776;5252.29094072303;5268.552173065255;5324.334458192726;5330;5337.51962323385;2941.808782429135;2961.925951851178;2968.847585500495;2972.9554056689167;2990.8055976361466;5514.821645450024;5741;5806.622569532967;5823.79616713413;5849.53203743708;5729.226554415184;5735.741891614887;5735.741891614887;5737.139429085671;5746.913796293059;5811.79658711943;5818.55620639324;5837.854053648693;5849.912251316234;5859;5428.782848686008;5699.202111704448;5720.570957178145;5721.771129154954;5739.2252045973255;5625.887482250414;5640.182173584889;5642.069058605448;5649.350324712711;5681.289838770153;5688.63023903445;5878.3239927408895;5919.348871624032;5930.436608522184;5947.821565353046;4010.659093976928;4019.598040195957;4025.4565633639086;4031.5162180538523;4040.9797951010055;5707.714614269353;5719.714014299351;5727.140928860537;5727.627704199213;5745.368009519033;5469.371022332482;5538.335399752055;5560.998040705424;5574.080276754452;5620.943790562042;5529.778808847601;5531.612787105025;5535.640183388067;5540.7783688652;5603.131514615241;5231.790728370823;5271.393789714232;5444.373897001896;5465.7813687453645;5548.528375088163;5547;5557.722113894209;5561.443855614406;5571.164325351229;5576.191452239484;5387.838364849061;5440.347158341025;5458.317710286215;5520.641158324696;5528.51216952365 06:09:35 INFO - PROCESS | 11003 | |5;yui.html;809.4374409785198;809.951402915825;826.177952936828;838.5807096451774;858.5363903492115;14677.41290348386;15680.52958411248;15689.52931412058;15816.44642437515;15868;14407.42370305189;14547.127172369665;14736.115833050024;14751.336189871454;14757.704845903076;806.8507326144668;826.7437094500694;837.1210229259284;837.7738010737097;838.1450920061534;659.1793217444289;804.2801692485223;836.017679226909;838.7944953486374;839.1273076000982;864.1660797330575;867.4578388507183;873.6068769053951;873.8863947686792;877.5656050255133;857.755539671197;858.1761508951414;858.6307887608326;859.3297228162044;859.7377799771067;507.94158671752854;619.7273199792077;630.4168644004324;632.6235889645653;633.9017452294902;14536.200508972002;15161.696766064728;15181.620459488491;15190.316435760307;15218.847811521853;14070.859291407058;14072.92963535186;14359.928200359036;14511;14568.125912445286;13195.538156164585;13258.734825303536;13364.799528007088;13395.531156409479;13562.389692463863;4465.843695470676;4480.977595112004;4506.1663592235545;4570.291604801261;4602;76368.61815690942;76401.61799191024;76698.23301766967;78055.21944780536;79587.60206198989;11619.477123529461;11681.76636467266;11711.355875426763;11718.88281117178;11904.821427678591;22456.32631021072;22470.32589022332;22484.437889052577;22799.31602051941;22856.771432285797;8627.78430539229;8692.434991725644;8771.342149338825;8894;8899.911000890037;4759.16714574948;4818.494058123917;4866.7566621668775;4871.878203044952;4977.676451030671;3405.387030334514;3468.8785892493643;3473.9925421627445;3478.3738926993383;3496.2133519958315;619.3899009475663;619.9907001394982;622.8411755002445;642.6047980491963;644.0275184471388;566.5863919338906;615.9384061593894;635.3900255754528;644.7936660268763;656.8456412743002;9044.728658140266;9282.118198771106;9366.812663746687;9544.42733435996;9571.1864491519;619.9690015499207;642.3480167629859;643.8004218692221;657.8815813153583;676.4047638078558;4231.505865453692;4473.284274516127;4516.548345165523;4542.500324964251;4589.58693717567;121745;122290.3885480567;123057;124740.37629811793;124861;106446;107683;110200;111840;113520.43239783749;76556.23443765602;77123.61438192773;86223;87126.56436717777;89538;9191.480871864094;9359.251259899327;9554.187894029086;9943.651972180938;10220;37448.812755936044;43984.560154398045;51225.74387128041;51299.74350128225;53739.19391209213;64663;67148.6642566784;70945;72417.6379118101;73279.26720732724;11660.53357865676;12137.939310303393;12303.384830758605;12442.37788110609;12532.122751407314;13902.374393152535;13994.300284985913;14099.365528551034;14356.569302920929;14675;12845.67885802825;12988.870111298766;13212.801807973081;13611.591652250449;14573.344199511259;13592.524261650795;13965.301734913417;14440.422383104558;14918.701625967204;14954;12466.5013399463;12910.67723306925;13038.152520086163;13204.339783011003;13343;11427;11580.536778528765;11710.707232318919;11727.530898764295;11734.178607497393;11157.49791259379;11401.491671832184;11489.08087352993;11507;11680.47437865315 06:09:35 INFO - PROCESS | 11003 | __end_tp_report 06:09:35 INFO - PROCESS | 11003 | __start_cc_report 06:09:35 INFO - PROCESS | 11003 | _x_x_mozilla_cycle_collect,937 06:09:35 INFO - PROCESS | 11003 | __end_cc_report 06:09:35 INFO - PROCESS | 11003 | __startTimestamp1469365775670__endTimestamp 06:09:35 INFO - PROCESS | 11003 | 06:09:35 INFO - PROCESS | 11003 | ------- Summary: start ------- 06:09:35 INFO - PROCESS | 11003 | Number of tests: 6 06:09:35 INFO - PROCESS | 11003 | 06:09:35 INFO - PROCESS | 11003 | [#0] dojo.html Cycles:165 Average:5293.54 Median:5480.40 stddev:594.74 (10.9%) stddev-sans-first:570.64 06:09:35 INFO - PROCESS | 11003 | Values: 3079.9 3084.1 3103.1 3124.3 3151.0 5148.2 5219.1 5325.4 5410.7 5439.2 5219.5 5278.4 5304.5 5346.3 5378.7 4740.7 4771.1 4818.7 4823.3 4992.4 4919.1 4932.8 4945.4 4947.9 4968.5 4750.5 4790.5 4895.6 4950.1 4952.0 4743.1 4785.4 4791.6 4845.2 4854.3 4822.2 4826.4 4840.6 4883.3 4914.5 5223.5 5404.5 5407.2 5423.6 5443.4 5519.2 5579.6 5581.4 5595.4 5643.1 5632.7 5642.3 5680.1 5698.2 5700.4 5102.3 5277.1 5313.4 5315.2 5333.8 5831.1 5883.0 5888.3 5933.9 5944.3 5645.6 5649.2 5684.5 5692.8 5696.2 5396.0 5587.7 5687.4 5747.8 5755.4 5626.8 5642.2 5647.6 5696.8 5700.9 5622.6 5646.3 5652.8 5655.6 5657.6 4225.2 4308.3 4375.3 4375.9 4423.1 3837.6 3866.7 3889.7 3952.6 3967.1 5370.5 5377.4 5378.5 5382.6 5383.7 5653.8 5668.7 5672.3 5707.4 5725.1 5250.6 5385.3 5411.3 5439.9 5511.2 4975.5 4982.6 4983.8 4987.8 5031.2 5911.8 5949.8 5967.6 5968.5 5976.0 5473.3 5612.9 5656.8 5657.4 5730.7 5861.2 5879.5 5887.8 5888.0 5895.1 5484.3 5530.9 5533.3 5536.7 5567.3 5544.4 5697.7 5711.7 5751.7 5841.7 5657.8 5659.9 5661.3 5661.3 5663.5 5586.0 5624.5 5649.7 5657.6 5664.3 5313.5 5423.7 5456.8 5481.6 5548.5 5586.6 5587.4 5636.8 5651.7 5652.9 5469.9 5475.4 5477.5 5480.4 5482.9 06:09:35 INFO - PROCESS | 11003 | 06:09:35 INFO - PROCESS | 11003 | [#1] ext.html Cycles:180 Average:58509.28 Median:37984.31 stddev:112565.39 (296.3%) stddev-sans-first:112797.21 06:09:35 INFO - PROCESS | 11003 | Values: 602.8 602.9 631.4 645.2 663.9 30737.4 42913.0 44305.8 44330.3 44388.8 44600.3 44949.8 45082.5 45204.8 45249.3 8025.2 8910.7 9061.2 9066.5 10445.3 10329.3 10773.5 10782.9 10797.2 10811.6 10904.7 10958.5 10958.7 10967.5 10978.1 8025.5 10789.6 10835.6 10863.3 11128.4 10648.0 10714.6 10718.6 10722.4 10723.2 42489.6 42849.4 42984.8 43066.4 43103.8 3474.4 3676.9 3764.1 3764.6 4237.8 32041.4 32644.3 32739.7 32792.5 32818.2 4376.4 4419.4 4421.6 4432.6 4450.1 343425.0 346241.0 346785.0 346973.0 346987.0 56810.4 57485.7 57606.0 57606.7 57638.1 60077.7 60168.4 60207.0 60257.0 60307.4 14992.3 15187.7 15188.8 15199.0 15207.1 10367.6 10512.1 10634.3 10727.0 11512.2 16603.2 16624.4 16629.6 16636.9 16696.7 5783.7 5906.7 5971.8 6001.8 6115.8 792.3 853.2 896.0 938.0 1035.1 31232.4 31933.7 32031.5 32143.5 32314.8 1060.9 1089.9 1097.9 1137.2 1203.0 16409.4 17113.7 17124.9 17222.9 17235.0 496873.0 500710.0 501429.0 502625.0 503998.0 56259.4 56352.7 56492.7 56591.7 56600.0 1198.6 1304.7 1323.2 1339.1 1340.3 30441.7 31746.0 32223.7 32323.8 32951.8 50400.5 51229.5 51293.5 51439.2 51503.2 410045.0 414953.0 415737.0 418430.0 418957.0 26485.6 27013.6 27154.6 28519.6 28677.4 47638.3 47761.5 48239.0 48524.8 48726.3 39874.0 40571.0 41731.8 41838.6 42612.4 40584.6 40660.8 41592.6 42369.4 42770.8 38027.6 39117.8 40181.6 40250.2 42359.8 32806.8 36657.8 36976.0 37718.2 37941.0 27488.6 27936.7 28128.9 28135.3 28148.7 06:09:35 INFO - PROCESS | 11003 | 06:09:35 INFO - PROCESS | 11003 | [#2] jquery.html Cycles:180 Average:27680.58 Median:23250.27 stddev:78190.91 (336.3%) stddev-sans-first:78383.37 06:09:35 INFO - PROCESS | 11003 | Values: 371.2 392.2 394.3 397.8 412.8 14133.6 17096.6 19271.2 19561.9 19569.3 18822.7 18856.3 19003.2 19007.4 19188.1 4025.8 5515.4 5693.5 5695.2 5722.7 5352.2 6334.3 6414.7 6465.1 6477.5 6124.5 6271.7 6275.8 6449.8 6453.5 6315.2 6333.7 6345.2 6346.4 6352.9 5411.5 5558.6 5603.4 5605.2 5617.4 22830.2 23049.0 23451.5 23458.1 23574.8 2257.5 2261.4 2304.5 2359.1 2382.2 13878.2 14221.4 14281.5 14314.5 14742.4 1964.7 1965.9 2019.7 2022.6 2069.3 77722.0 78224.6 78830.6 79117.2 79319.2 10120.2 10285.9 10506.9 10586.0 10729.9 14816.6 14856.7 14863.1 14888.0 14891.6 7606.2 7824.4 7863.1 8011.3 8169.5 7489.3 7493.9 7534.7 7755.7 7849.3 6430.0 6574.0 6666.7 6681.9 6761.0 1830.6 1871.3 1874.4 1880.1 1930.4 1007.8 1031.0 1035.4 1064.7 1094.6 19146.4 19493.4 19546.4 19718.9 20060.2 1004.7 1012.2 1015.7 1036.8 1059.4 10380.8 11102.9 11218.3 11222.9 11302.0 457570.0 460238.0 481226.0 491477.0 493823.0 48713.0 57436.7 66496.3 66951.3 80156.0 964.5 975.7 998.2 1019.9 1030.5 16084.4 16250.9 16548.7 17187.8 17797.2 40283.2 41477.6 41636.6 43509.0 44390.3 52695.7 54098.5 54540.5 55800.4 56206.0 7077.5 7993.7 8025.6 8031.8 8187.2 10581.7 12595.4 12918.9 12964.7 13231.9 10622.3 10636.3 11130.8 11337.1 11389.9 10986.7 11059.7 11131.3 11222.9 11254.1 10649.9 10854.9 11193.4 11204.3 11480.8 7204.3 7311.3 7356.9 7424.8 7504.3 9427.5 10511.5 10648.8 10705.9 11004.6 06:09:35 INFO - PROCESS | 11003 | 06:09:35 INFO - PROCESS | 11003 | [#3] mootools.html Cycles:180 Average:5655.48 Median:4732.82 stddev:3187.98 (67.4%) stddev-sans-first:3180.42 06:09:35 INFO - PROCESS | 11003 | Values: 1339.6 1445.8 1485.2 1708.3 1771.1 8302.5 8787.6 8806.4 8817.3 8822.7 7318.6 8125.1 8333.5 8346.5 8655.9 2288.1 2316.6 2317.3 2317.9 2321.0 2287.7 2291.2 2334.2 2341.7 2350.1 1884.8 2160.2 2196.6 2218.5 2234.6 2258.9 2259.4 2274.7 2284.8 2285.5 2247.4 2255.4 2262.5 2263.1 2265.2 8533.0 8559.7 8567.2 8571.4 8571.5 4918.1 5084.8 5086.0 5093.1 5094.5 3090.7 3164.9 3304.1 3309.1 3322.0 1056.3 1062.9 1085.2 1088.5 1099.1 11836.6 11914.8 11920.0 11920.7 11924.3 4236.3 4406.4 4418.8 4561.0 4563.9 10043.8 10048.4 10049.1 10050.1 10050.3 5049.2 5065.7 5096.8 5105.8 5114.3 4661.9 4719.3 4732.8 4732.9 4757.5 3852.1 3874.7 3901.8 3938.1 3965.2 1209.8 1213.2 1218.2 1224.9 1229.8 737.6 883.7 903.6 959.5 1012.7 5710.4 5832.1 5904.6 5987.1 6124.7 987.4 988.5 1000.2 1001.9 1045.8 3922.9 4279.3 4295.6 4299.9 4408.4 10294.3 10605.2 10611.4 10636.5 10714.8 10517.2 10543.4 10595.7 10600.9 10673.7 7926.8 7948.2 7952.9 8011.3 8021.2 5739.3 5762.2 5879.8 5896.4 6014.0 9777.2 9804.5 9855.4 9928.7 9964.9 9944.9 10110.1 10126.0 10147.1 10158.1 7586.1 7622.8 7623.0 7626.1 7659.1 7948.6 7969.6 8102.3 8228.2 8276.3 5689.8 7315.2 7385.2 7398.4 7401.6 7193.7 7209.4 7257.0 7279.8 7345.9 6727.1 6833.6 6841.4 6842.2 6848.4 5272.0 5299.1 5349.1 5394.3 5536.1 5337.4 5370.2 5394.5 5445.3 5474.9 06:09:35 INFO - PROCESS | 11003 | 06:09:35 INFO - PROCESS | 11003 | [#4] prototype.html Cycles:180 Average:4652.68 Median:5327.41 stddev:1365.80 (25.6%) stddev-sans-first:1330.26 06:09:35 INFO - PROCESS | 11003 | Values: 315.4 316.2 323.3 323.7 332.4 5279.5 5318.7 5324.8 5330.4 5368.8 4969.2 5085.1 5093.9 5113.9 5256.4 3995.1 4041.5 4086.2 4116.8 4117.4 4084.9 4095.3 4101.3 4108.4 4140.6 3939.9 4076.7 4084.5 4100.3 4109.2 4076.9 4086.6 4099.1 4102.6 4104.7 3619.0 3630.3 3639.6 3650.4 3652.8 4870.4 5141.4 5175.4 5175.8 5187.9 4671.7 4707.6 4713.3 4736.4 4747.9 5507.8 5513.3 5515.7 5528.0 5546.3 3865.4 3997.7 4003.2 4004.2 4026.7 5683.6 5686.3 5698.9 5716.7 5718.9 4052.8 4054.6 4054.8 4069.3 4075.7 4100.9 4119.6 4123.3 4128.9 4134.0 4519.2 4642.0 4694.0 4700.8 4743.5 5453.5 5517.6 5520.2 5528.8 5536.6 1365.5 1400.7 1408.0 1414.2 1425.6 973.8 992.5 1000.6 1002.0 1005.5 5333.9 5339.0 5346.6 5361.9 5372.9 5471.2 5596.9 5614.0 5647.4 5656.7 5252.3 5268.6 5324.3 5330.0 5337.5 2941.8 2961.9 2968.8 2973.0 2990.8 5514.8 5741.0 5806.6 5823.8 5849.5 5729.2 5735.7 5735.7 5737.1 5746.9 5811.8 5818.6 5837.9 5849.9 5859.0 5428.8 5699.2 5720.6 5721.8 5739.2 5625.9 5640.2 5642.1 5649.4 5681.3 5688.6 5878.3 5919.3 5930.4 5947.8 4010.7 4019.6 4025.5 4031.5 4041.0 5707.7 5719.7 5727.1 5727.6 5745.4 5469.4 5538.3 5561.0 5574.1 5620.9 5529.8 5531.6 5535.6 5540.8 5603.1 5231.8 5271.4 5444.4 5465.8 5548.5 5547.0 5557.7 5561.4 5571.2 5576.2 5387.8 5440.3 5458.3 5520.6 5528.5 06:09:35 INFO - PROCESS | 11003 | 06:09:35 INFO - PROCESS | 11003 | [#5] yui.html Cycles:180 Average:21128.29 Median:4477.13 stddev:31086.27 (694.3%) stddev-sans-first:31136.03 06:09:35 INFO - PROCESS | 11003 | Values: 809.4 810.0 826.2 838.6 858.5 14677.4 15680.5 15689.5 15816.4 15868.0 14407.4 14547.1 14736.1 14751.3 14757.7 806.9 826.7 837.1 837.8 838.1 659.2 804.3 836.0 838.8 839.1 864.2 867.5 873.6 873.9 877.6 857.8 858.2 858.6 859.3 859.7 507.9 619.7 630.4 632.6 633.9 14536.2 15161.7 15181.6 15190.3 15218.8 14070.9 14072.9 14359.9 14511.0 14568.1 13195.5 13258.7 13364.8 13395.5 13562.4 4465.8 4481.0 4506.2 4570.3 4602.0 76368.6 76401.6 76698.2 78055.2 79587.6 11619.5 11681.8 11711.4 11718.9 11904.8 22456.3 22470.3 22484.4 22799.3 22856.8 8627.8 8692.4 8771.3 8894.0 8899.9 4759.2 4818.5 4866.8 4871.9 4977.7 3405.4 3468.9 3474.0 3478.4 3496.2 619.4 620.0 622.8 642.6 644.0 566.6 615.9 635.4 644.8 656.8 9044.7 9282.1 9366.8 9544.4 9571.2 620.0 642.3 643.8 657.9 676.4 4231.5 4473.3 4516.5 4542.5 4589.6 121745.0 122290.4 123057.0 124740.4 124861.0 106446.0 107683.0 110200.0 111840.0 113520.4 76556.2 77123.6 86223.0 87126.6 89538.0 9191.5 9359.3 9554.2 9943.7 10220.0 37448.8 43984.6 51225.7 51299.7 53739.2 64663.0 67148.7 70945.0 72417.6 73279.3 11660.5 12137.9 12303.4 12442.4 12532.1 13902.4 13994.3 14099.4 14356.6 14675.0 12845.7 12988.9 13212.8 13611.6 14573.3 13592.5 13965.3 14440.4 14918.7 14954.0 12466.5 12910.7 13038.2 13204.3 13343.0 11427.0 11580.5 11710.7 11727.5 11734.2 11157.5 11401.5 11489.1 11507.0 11680.5 06:09:35 INFO - PROCESS | 11003 | -------- Summary: end -------- 06:09:35 INFO - PROCESS | 11003 | 06:09:36 INFO - TEST-INFO | 11003: exit 0 06:09:36 INFO - TEST-OK | dromaeo_css | took 1113843ms 06:09:36 INFO - TEST-START | kraken 06:09:36 INFO - operating with platform_type : linux_ 06:09:36 INFO - Initialising browser for kraken test... 06:09:36 INFO - TEST-INFO | started process 11190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmFpD3y/profile http://localhost:34936/getInfo.html) 06:09:39 INFO - PROCESS | 11190 | JavaScript error: , line 0: uncaught exception: undefined 06:09:40 INFO - PROCESS | 11190 | __metrics Screen width/height:1600/1200 06:09:40 INFO - PROCESS | 11190 | colorDepth:24 06:09:40 INFO - PROCESS | 11190 | Browser inner width/height: 1024/697 06:09:40 INFO - PROCESS | 11190 | __metrics 06:09:41 INFO - PROCESS | 11190 | 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" 06:09:41 INFO - PROCESS | 11190 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:09:41 INFO - TEST-INFO | 11190: exit 0 06:09:41 INFO - Browser initialized. 06:09:41 INFO - Running cycle 1/1 for kraken test... 06:09:41 INFO - TEST-INFO | started process 11273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmFpD3y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:53 INFO - PROCESS | 11273 | RSS: Main: 157470720 06:09:53 INFO - PROCESS | 11273 | 06:09:56 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34936/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:57 INFO - PROCESS | 11273 | RSS: Main: 214560768 06:09:57 INFO - PROCESS | 11273 | 06:09:59 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34936/tests/kraken/driver.html?testName=audio-dft) 06:10:00 INFO - PROCESS | 11273 | RSS: Main: 193409024 06:10:00 INFO - PROCESS | 11273 | 06:10:03 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34936/tests/kraken/driver.html?testName=audio-fft) 06:10:04 INFO - PROCESS | 11273 | RSS: Main: 271876096 06:10:04 INFO - PROCESS | 11273 | 06:10:06 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34936/tests/kraken/driver.html?testName=audio-oscillator) 06:10:06 INFO - PROCESS | 11273 | RSS: Main: 181235712 06:10:06 INFO - PROCESS | 11273 | 06:10:09 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34936/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:09 INFO - PROCESS | 11273 | RSS: Main: 185495552 06:10:09 INFO - PROCESS | 11273 | 06:10:12 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34936/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:13 INFO - PROCESS | 11273 | RSS: Main: 220811264 06:10:13 INFO - PROCESS | 11273 | 06:10:16 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34936/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:17 INFO - PROCESS | 11273 | RSS: Main: 221233152 06:10:17 INFO - PROCESS | 11273 | 06:10:20 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34936/tests/kraken/driver.html?testName=json-parse-financial) 06:10:20 INFO - PROCESS | 11273 | RSS: Main: 221224960 06:10:20 INFO - PROCESS | 11273 | 06:10:22 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34936/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:10:22 INFO - PROCESS | 11273 | RSS: Main: 185569280 06:10:22 INFO - PROCESS | 11273 | 06:10:24 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34936/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:10:25 INFO - PROCESS | 11273 | RSS: Main: 189820928 06:10:25 INFO - PROCESS | 11273 | 06:10:27 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34936/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:10:27 INFO - PROCESS | 11273 | RSS: Main: 195514368 06:10:27 INFO - PROCESS | 11273 | 06:10:30 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:30 INFO - PROCESS | 11273 | RSS: Main: 189644800 06:10:30 INFO - PROCESS | 11273 | 06:10:33 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:34 INFO - PROCESS | 11273 | RSS: Main: 193888256 06:10:34 INFO - PROCESS | 11273 | 06:10:35 INFO - PROCESS | 11273 | Cycle 1(1): loaded http://localhost:34936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34936/tests/kraken/driver.html?testName=ai-astar) 06:10:36 INFO - PROCESS | 11273 | RSS: Main: 245157888 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | __start_tp_report 06:10:36 INFO - PROCESS | 11273 | _x_x_mozilla_page_load 06:10:36 INFO - PROCESS | 11273 | _x_x_mozilla_page_load_details 06:10:36 INFO - PROCESS | 11273 | |i|pagename|runs| 06:10:36 INFO - PROCESS | 11273 | |0;ai-astar;103;110;109;111;111;109;111;110;109;111 06:10:36 INFO - PROCESS | 11273 | |1;audio-beat-detection;145;123;125;179;118;119;143;119;159;119 06:10:36 INFO - PROCESS | 11273 | |2;audio-dft;161;162;160;161;161;161;168;160;163;162 06:10:36 INFO - PROCESS | 11273 | |3;audio-fft;75;76;74;113;75;76;74;74;100;74 06:10:36 INFO - PROCESS | 11273 | |4;audio-oscillator;84;86;127;84;84;84;121;84;83;131 06:10:36 INFO - PROCESS | 11273 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 06:10:36 INFO - PROCESS | 11273 | |6;imaging-darkroom;146;145;146;145;146;146;145;145;146;145 06:10:36 INFO - PROCESS | 11273 | |7;imaging-desaturate;95;95;95;96;95;95;96;95;94;95 06:10:36 INFO - PROCESS | 11273 | |8;json-parse-financial;54;51;52;51;53;53;51;53;51;51 06:10:36 INFO - PROCESS | 11273 | |9;json-stringify-tinderbox;62;62;62;62;62;61;62;62;67;63 06:10:36 INFO - PROCESS | 11273 | |10;stanford-crypto-aes;75;76;75;76;75;85;83;76;75;74 06:10:36 INFO - PROCESS | 11273 | |11;stanford-crypto-ccm;124;118;124;118;126;117;131;120;172;133 06:10:36 INFO - PROCESS | 11273 | |12;stanford-crypto-pbkdf2;154;155;153;155;154;161;157;156;153;159 06:10:36 INFO - PROCESS | 11273 | |13;stanford-crypto-sha256-iterative;63;62;64;62;61;65;61;61;61;61 06:10:36 INFO - PROCESS | 11273 | __end_tp_report 06:10:36 INFO - PROCESS | 11273 | __start_cc_report 06:10:36 INFO - PROCESS | 11273 | _x_x_mozilla_cycle_collect,1706 06:10:36 INFO - PROCESS | 11273 | __end_cc_report 06:10:36 INFO - PROCESS | 11273 | __startTimestamp1469365836084__endTimestamp 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | ------- Summary: start ------- 06:10:36 INFO - PROCESS | 11273 | Number of tests: 14 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:2.41 (2.2%) stddev-sans-first:0.93 06:10:36 INFO - PROCESS | 11273 | Values: 103.0 110.0 109.0 111.0 111.0 109.0 111.0 110.0 109.0 111.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:134.00 stddev:21.02 (15.7%) stddev-sans-first:21.98 06:10:36 INFO - PROCESS | 11273 | Values: 145.0 123.0 125.0 179.0 118.0 119.0 143.0 119.0 159.0 119.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.50 stddev:2.33 (1.4%) stddev-sans-first:2.45 06:10:36 INFO - PROCESS | 11273 | Values: 161.0 162.0 160.0 161.0 161.0 161.0 168.0 160.0 163.0 162.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.50 stddev:13.76 (18.5%) stddev-sans-first:14.41 06:10:36 INFO - PROCESS | 11273 | Values: 75.0 76.0 74.0 113.0 75.0 76.0 74.0 74.0 100.0 74.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:84.00 stddev:20.53 (24.4%) stddev-sans-first:21.25 06:10:36 INFO - PROCESS | 11273 | Values: 84.0 86.0 127.0 84.0 84.0 84.0 121.0 84.0 83.0 131.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:10:36 INFO - PROCESS | 11273 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:10:36 INFO - PROCESS | 11273 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:10:36 INFO - PROCESS | 11273 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 94.0 95.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.50 stddev:1.15 (2.2%) stddev-sans-first:0.97 06:10:36 INFO - PROCESS | 11273 | Values: 54.0 51.0 52.0 51.0 53.0 53.0 51.0 53.0 51.0 51.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:1.65 (2.7%) stddev-sans-first:1.74 06:10:36 INFO - PROCESS | 11273 | Values: 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 67.0 63.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:3.77 (5.0%) stddev-sans-first:3.93 06:10:36 INFO - PROCESS | 11273 | Values: 75.0 76.0 75.0 76.0 75.0 85.0 83.0 76.0 75.0 74.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:125.00 stddev:16.30 (13.0%) stddev-sans-first:17.21 06:10:36 INFO - PROCESS | 11273 | Values: 124.0 118.0 124.0 118.0 126.0 117.0 131.0 120.0 172.0 133.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:155.50 stddev:2.63 (1.7%) stddev-sans-first:2.71 06:10:36 INFO - PROCESS | 11273 | Values: 154.0 155.0 153.0 155.0 154.0 161.0 157.0 156.0 153.0 159.0 06:10:36 INFO - PROCESS | 11273 | 06:10:36 INFO - PROCESS | 11273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.45 (2.3%) stddev-sans-first:1.50 06:10:36 INFO - PROCESS | 11273 | Values: 63.0 62.0 64.0 62.0 61.0 65.0 61.0 61.0 61.0 61.0 06:10:36 INFO - PROCESS | 11273 | -------- Summary: end -------- 06:10:36 INFO - PROCESS | 11273 | 06:10:37 INFO - TEST-INFO | 11273: exit 0 06:10:37 INFO - TEST-OK | kraken | took 60715ms 06:10:37 INFO - SUITE-END | took 1174s 06:10:37 INFO - Completed test suite (00:19:34) 06:10:37 INFO - javascript benchmark 06:10:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.9076027719166, 3084.1056093732805, 3103.069079276217, 3124.343887783565, 3151.023182813328, 5148.150555158394, 5219.112750832358, 5325.4142044375085, 5410.702411367373, 5439.238506609078, 5219.45195754446, 5278.3665960084745, 5304.522592966632, 5346.251524786533, 5378.677279363241, 4740.739259340744, 4771.141194584973, 4818.71087734737, 4823.276508523714, 4992.375953005874, 4919.13915064864, 4932.827351042714, 4945.381827271591, 4947.851564453073, 4968.478309777475, 4750.477447480775, 4790.496997815214, 4895.55939965403, 4950.133726597867, 4951.950480495203, 4743.075100355432, 4785.353977213066, 4791.6406269529925, 4845.176320025604, 4854.344663470457, 4822.180229361017, 4826.420829500447, 4840.636952228597, 4883.267509873512, 4914.533119353656, 5223.477652234784, 5404.4595540446035, 5407.242985981966, 5423.620346575742, 5443.401225865152, 5519.227308176858, 5579.609427340088, 5581.441855814427, 5595.412481689405, 5643.097104463307, 5632.690202038886, 5642.266505354278, 5680.11958146488, 5698.202251684767, 5700.37295897451, 5102.260172275037, 5277.129273669878, 5313.415524292324, 5315.202719592015, 5333.759980800874, 5831.096180092092, 5883.0, 5888.293404791367, 5933.881322373529, 5944.286685597669, 5645.576581756384, 5649.237352957298, 5684.54523638108, 5692.829215123553, 5696.202531645573, 5395.973020134953, 5587.74855131512, 5687.40282270364, 5747.827565173052, 5755.366909639936, 5626.774929002876, 5642.181883626851, 5647.576431767634, 5696.772129114872, 5700.8859822803315, 5622.634528755618, 5646.2942132233475, 5652.802151924663, 5655.632383895034, 5657.632253903483, 4225.176090662353, 4308.332208507686, 4375.343698445258, 4375.890602734893, 4423.093265880487, 3837.6354246346555, 3866.709996750255, 3889.7277190596387, 3952.565217826037, 3967.127232009011, 5370.516653501204, 5377.381601115843, 5378.489043540857, 5382.623216374895, 5383.703896285742, 5653.802116925888, 5668.744906479218, 5672.290963629546, 5707.3721890592005, 5725.055365864586, 5250.579953603703, 5385.299911011543, 5411.269478620336, 5439.945600543944, 5511.173324001352, 4975.4527002029745, 4982.551570358685, 4983.775730092155, 4987.80048798044, 5031.169856973558, 5911.822645320647, 5949.791757288474, 5967.6419414835245, 5968.492678122321, 5976.043832986701, 5473.343198816167, 5612.85967850807, 5656.8020119295625, 5657.405972373006, 5730.74211660468, 5861.1501332305725, 5879.529637629065, 5887.764489420375, 5888.0, 5895.145203945318, 5484.341878974548, 5530.861728456821, 5533.335999680065, 5536.667799932017, 5567.2762540871045, 5544.390117087037, 5697.686627235376, 5711.7429715662065, 5751.74117164737, 5841.707914604338, 5657.8019769307875, 5659.943400566106, 5661.320641523043, 5661.348944871228, 5663.5469162467725, 5585.994520986099, 5624.521915637217, 5649.68926709035, 5657.60396772222, 5664.26364572603, 5313.495217954288, 5423.701696406735, 5456.809011684572, 5481.643693159932, 5548.500634942875, 5586.608937374344, 5587.385387607441, 5636.802711905064, 5651.660900345828, 5652.85867853307, 5469.945300546943, 5475.397706252229, 5477.452254774491, 5480.3971563128825, 5482.945170548243], "value": 5253.994053258544, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.801075645037, 602.8643555200081, 631.4159402552639, 645.2450632759668, 663.8705452436777, 30737.385252294967, 42913.0, 44305.7784711076, 44330.33504497427, 44388.77805610967, 44600.330995035016, 44949.7752511237, 45082.54917450825, 45204.773976130076, 45249.321260181125, 8025.197480251986, 8910.688125915578, 9061.184493395593, 9066.546672666373, 10445.26883118182, 10329.276950613461, 10773.515191816348, 10782.892171078307, 10797.190210734187, 10811.621593244237, 10904.672859814218, 10958.506867190996, 10958.726031849188, 10967.451627418637, 10978.12175026, 8025.478343907627, 10789.568417263301, 10835.566577336896, 10863.29388589743, 11128.38793866337, 10648.0, 10714.624988125379, 10718.571257149704, 10722.356658600509, 10723.249372543925, 42489.57510424918, 42849.35725964113, 42984.78507607442, 43066.35400468996, 43103.78448107771, 3474.409350410436, 3676.8529258829612, 3764.1154328733, 3764.5858955515146, 4237.788110594489, 32041.359172816647, 32644.347113057844, 32739.6726032739, 32792.5081123781, 32818.17954551132, 4376.3654270130655, 4419.4254746883025, 4421.60205581496, 4432.645388368923, 4450.132224216279, 343425.0, 346241.0, 346785.0, 346973.0, 346987.0, 56810.431895680515, 57485.71257143771, 57606.0, 57606.7119664399, 57638.13542796861, 60077.69961150167, 60168.39831601628, 60207.0, 60257.0, 60307.396926031055, 14992.325345359484, 15187.696246075238, 15188.848111518964, 15199.0, 15207.08757474555, 10367.63713270032, 10512.106470949902, 10634.30876992993, 10727.0, 11512.194146409838, 16603.169841507875, 16624.418145364853, 16629.584260393345, 16636.916815415847, 16696.74954875678, 5783.681897495594, 5906.704664766745, 5971.7611295547695, 6001.819945401645, 6115.847103822351, 792.2869417524274, 853.2022558907441, 895.9910400895908, 937.9718608441758, 1035.089121573011, 31232.438378081006, 31933.680663193536, 32031.51952720711, 32143.51784723231, 32314.83842580819, 1060.9363438193734, 1089.8937578357973, 1097.8902109789117, 1137.1869113583828, 1202.9759404811855, 16409.42567010149, 17113.743293850603, 17124.914375428045, 17222.91388543049, 17235.0, 496873.0, 500710.0, 501429.0, 502625.0, 503998.0, 56259.43740562542, 56352.71823640855, 56492.717536412056, 56591.71704141535, 56600.0, 1198.5924785572947, 1304.6868751499571, 1323.1928523600595, 1339.1028011232304, 1340.3432318164225, 30441.695583043886, 31746.0, 32223.67776322207, 32323.838380807945, 32951.835240823646, 50400.49599503958, 51229.48770512247, 51293.487065130364, 51439.22841157311, 51503.227451589, 410045.0, 414953.0, 415737.0, 418430.0, 418957.0, 26485.602715958892, 27013.59479607847, 27154.592681109403, 28519.572206416506, 28677.426451470437, 47638.28542571795, 47761.5223847771, 48238.970128733905, 48524.757376212896, 48726.26910596273, 39874.0, 40571.0, 41731.7913410431, 41838.58161418469, 42612.360814587184, 40584.59415405808, 40660.79669601633, 41592.58407415887, 42369.36445953252, 42770.78614606907, 38027.61972380241, 39117.80441097776, 40181.598184018956, 40250.19499609933, 42359.7882010588, 32806.83596582002, 36657.816710916275, 36976.0, 37718.2456350877, 37941.0, 27488.58767118535, 27936.720632794226, 28128.85935570309, 28135.296617584725, 28148.71851281461], "value": 20084.372830087712, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.1500663480629, 392.2351414741255, 394.3453866581475, 397.83688687638073, 412.83486605357854, 14133.646658833535, 17096.57258568535, 19271.22915083395, 19561.90219048906, 19569.315073972397, 18822.71765923512, 18856.34002809902, 19003.239870405203, 19007.429777106674, 19188.136533855974, 4025.7987100644996, 5515.420880807507, 5693.487586117249, 5695.231143795576, 5722.656640601556, 5352.197170424429, 6334.271558770732, 6414.711337989802, 6465.09488671584, 6477.514186436013, 6124.540659450537, 6271.749130034793, 6275.811725648215, 6449.774257900975, 6453.548251622388, 6315.242170939494, 6333.651649159295, 6345.175127233453, 6346.397092276226, 6352.872942541147, 5411.485908838654, 5558.583106267006, 5603.3836278009385, 5605.159226116115, 5617.41017193197, 22830.200942967083, 23049.0, 23451.53096938069, 23458.06167753305, 23574.76425235743, 2257.4694946687514, 2261.3894248552797, 2304.5045315257134, 2359.0799588160457, 2382.1543352109925, 13878.167309961435, 14221.360038798279, 14281.500147494788, 14314.498992535211, 14742.41030358795, 1964.7052942058806, 1965.8525610579263, 2019.7374341335678, 2022.6157030164368, 2069.3274685727047, 77722.0, 78224.60887695524, 78830.6058469704, 79117.20882791156, 79319.20680793175, 10120.240981926385, 10285.897141028643, 10506.947465262625, 10586.04725574702, 10729.892701073046, 14816.629584260265, 14856.702865942621, 14863.108213507225, 14888.032277901902, 14891.627709307353, 7606.23937606246, 7824.37405007598, 7863.13505514393, 8011.278984891388, 8169.5098294102545, 7489.251074892576, 7493.88759168602, 7534.736284230025, 7755.72854950074, 7849.254320839511, 6430.0, 6574.0, 6666.666666666647, 6681.864083105884, 6760.966195168992, 1830.5606654403114, 1871.2608519634668, 1874.400191938594, 1880.125741530195, 1930.4401723500027, 1007.778288776468, 1030.99484502577, 1035.3684252605904, 1064.7148545054733, 1094.5676457799125, 19146.425607231806, 19493.415197544095, 19546.413607591796, 19718.90140549317, 20060.197592096152, 1004.7186787699455, 1012.2408193854609, 1015.7105225010837, 1036.7667274863095, 1059.3643813711865, 10380.83384567699, 11102.944485277683, 11218.270812397332, 11222.943885280521, 11302.0, 457570.0, 460238.0, 481226.0, 491477.0, 493823.0, 48713.0, 57436.71281643565, 66496.33503664902, 66951.33048669451, 80156.0, 964.5129209749032, 975.6829030565095, 998.2164001259122, 1019.8521214423866, 1030.525958059286, 16084.35662573484, 16250.918745406198, 16548.669026619158, 17187.82812171912, 17797.199126039617, 40283.17309855559, 41477.58522414737, 41636.58363416327, 43509.0, 44390.3341449872, 52695.73652131715, 54098.45901540934, 54540.454595453535, 55800.441995581146, 56206.0, 7077.504574679723, 7993.6802527898235, 8025.59872006409, 8031.799205019921, 8187.222213889671, 10581.682549523526, 12595.370231488205, 12918.870811291767, 12964.707406909025, 13231.933840331121, 10622.309549879234, 10636.255462117577, 11130.777384452427, 11337.093032557541, 11389.886101139215, 10986.670399888017, 11059.668209953714, 11131.341471908027, 11222.943885280521, 11254.099672026383, 10649.8935010652, 10854.891451085388, 11193.440327983406, 11204.271722338022, 11480.82778758336, 7204.3155900189395, 7311.341979221896, 7356.852862942604, 7424.814379640552, 7504.3246107850555, 9427.528623568931, 10511.526981286013, 10648.787024259627, 10705.89294107049, 11004.614838480615], "value": 9140.28685388969, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.5847287340926, 1445.8409574946754, 1485.2128371962856, 1708.2995971651626, 1771.0878897367859, 8302.460340077898, 8787.560621968907, 8806.383553151281, 8817.338699597523, 8822.735317940473, 7318.560886346823, 8125.106238313796, 8333.541655208961, 8346.499210047401, 8655.87016194756, 2288.141946769965, 2316.6177580699164, 2317.316391664463, 2317.9072837086496, 2321.036769740564, 2287.736910255317, 2291.186628746796, 2334.206369834256, 2341.718993720747, 2350.095213342867, 1884.7832499262622, 2160.2439146298825, 2196.6265734825038, 2218.4897473581086, 2234.6089434348924, 2258.8531745436494, 2259.378670865517, 2274.704288442492, 2284.805791507724, 2285.4743409015937, 2247.404437823978, 2255.357223191399, 2262.502249505106, 2263.0608297556496, 2265.2071774878827, 8532.957335213347, 8559.700410485666, 8567.186117318906, 8571.442856214326, 8571.528565928871, 4918.114739346916, 5084.79660813567, 5085.974570127126, 5093.1087059764395, 5094.541491265803, 3090.6909309069138, 3164.9208769780707, 3304.140923359944, 3309.0569187781366, 3322.0, 1056.281728424671, 1062.941538215398, 1085.1535802074395, 1088.4720910358549, 1099.0932480703373, 11836.644900652995, 11914.821277680756, 11920.046396288362, 11920.701982450508, 11924.284542927366, 4236.301010333322, 4406.383106365111, 4418.779061046999, 4560.977195114069, 4563.863084107482, 10043.849342259726, 10048.447335396624, 10049.145822605014, 10050.09549140581, 10050.346727462691, 5049.2426136079885, 5065.696058236444, 5096.770645320969, 5105.821296254613, 5114.28400023997, 4661.883452913704, 4719.315699223594, 4732.787024583902, 4732.858014259577, 4757.500462451393, 3852.0947577319307, 3874.651281384689, 3901.765894046366, 3938.0942383252013, 3965.1871366369824, 1209.8245754365569, 1213.235661533246, 1218.165556593736, 1224.9176400119832, 1229.7847876621556, 737.5611511150856, 883.7216276872764, 903.5527413930015, 959.4627008875052, 1012.6658202793061, 5710.400407957188, 5832.12518122285, 5904.586678932519, 5987.1318658794235, 6124.663143527148, 987.4124895687055, 988.5057471264367, 1000.2048371544639, 1001.9198464122853, 1045.8431235314763, 3922.9215415692097, 4279.33670281107, 4295.591918767712, 4299.892502687458, 4408.360787685768, 10294.279400442047, 10605.204609654307, 10611.41637209961, 10636.521356538975, 10714.821369649333, 10517.21120915919, 10543.42011189392, 10595.682129535971, 10600.946995265129, 10673.679789606324, 7926.801829954297, 7948.165442628557, 7952.880706789403, 8011.319037881729, 8021.2379823916635, 5739.339975902658, 5762.1644861494015, 5879.764809407576, 5896.439838215363, 6014.007688731311, 9777.16894063984, 9804.460754658563, 9855.408675479493, 9928.652497162564, 9964.850527242243, 9944.850827237742, 10110.140638045848, 10126.0, 10147.086762191439, 10158.08577228053, 7586.127595326608, 7622.847543048997, 7623.0, 7626.084869815658, 7659.080910290801, 7948.602569871599, 7969.641366138653, 8102.270795628186, 8228.21831925966, 8276.337892968668, 5689.800856969986, 7315.158756743042, 7385.224551422239, 7398.371138453292, 7401.59291238987, 7193.71225151009, 7209.3872020876715, 7256.963715181601, 7279.818004549928, 7345.926540734525, 6727.058211850443, 6833.5899846007405, 6841.3842754152365, 6842.178938527409, 6848.417884479875, 5271.973640131928, 5299.125644268806, 5349.090654588807, 5394.32570928634, 5536.141898005815, 5337.412884582771, 5370.167624018283, 5394.514493695587, 5445.292112025411, 5474.91787623194], "value": 4536.827225986115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.35195173917595, 316.16847690573786, 323.3274788440045, 323.6957260175435, 332.41660885146564, 5279.498447647472, 5318.707471089088, 5324.813631522898, 5330.440303768107, 5368.8389348319515, 4969.155243608586, 5085.084684756743, 5093.9235911461265, 5113.872153196163, 5256.421793602701, 3995.1011022519992, 4041.4544036555058, 4086.16233672098, 4116.75299482032, 4117.423560701504, 4084.856240252719, 4095.344744840826, 4101.302778527657, 4108.424820525129, 4140.5859414058505, 3939.901502462447, 4076.653484453825, 4084.4894388201474, 4100.323446631302, 4109.191955539553, 4076.8776936691797, 4086.5709100544314, 4099.077707515785, 4102.589741025873, 4104.712670113093, 3618.981905090484, 3630.2739452109686, 3639.5796795131205, 3650.4159334506353, 3652.7808331500196, 4870.391201099863, 5141.383034035902, 5175.430702622709, 5175.844724658266, 5187.922181167285, 4671.672982891199, 4707.5763181313505, 4713.316569097496, 4736.431628204603, 4747.8575642730775, 5507.779688812443, 5513.2908798272665, 5515.696636684981, 5528.0, 5546.251256080418, 3865.40086286626, 3997.7407116758127, 4003.1793482336343, 4004.2191772604356, 4026.6577340926056, 5683.5737319700775, 5686.289213848269, 5698.886022279573, 5716.742746576372, 5718.941995730803, 4052.797360131982, 4054.6350828425584, 4054.8378064877666, 4069.267531844237, 4075.65356944663, 4100.897477563085, 4119.629233369011, 4123.299039163349, 4128.876133715933, 4134.0, 4519.186546421675, 4642.025174713281, 4693.95306046942, 4700.764961751899, 4743.549362810528, 5453.454654534515, 5517.641353312022, 5520.199571062173, 5528.75120619573, 5536.612437129443, 1365.4742923974143, 1400.7268582626493, 1408.0284603623468, 1414.1797757300742, 1425.5794540610545, 973.7808992976666, 992.533509250651, 1000.5997600959674, 1001.9779824578889, 1005.4972513743129, 5333.919991200135, 5339.0, 5346.599005074635, 5361.946380536223, 5372.892542149135, 5471.206675032098, 5596.888062238732, 5614.0, 5647.37878833328, 5656.717164141776, 5252.29094072303, 5268.552173065255, 5324.334458192726, 5330.0, 5337.51962323385, 2941.808782429135, 2961.925951851178, 2968.847585500495, 2972.9554056689167, 2990.8055976361466, 5514.821645450024, 5741.0, 5806.622569532967, 5823.79616713413, 5849.53203743708, 5729.226554415184, 5735.741891614887, 5735.741891614887, 5737.139429085671, 5746.913796293059, 5811.79658711943, 5818.55620639324, 5837.854053648693, 5849.912251316234, 5859.0, 5428.782848686008, 5699.202111704448, 5720.570957178145, 5721.771129154954, 5739.2252045973255, 5625.887482250414, 5640.182173584889, 5642.069058605448, 5649.350324712711, 5681.289838770153, 5688.63023903445, 5878.3239927408895, 5919.348871624032, 5930.436608522184, 5947.821565353046, 4010.659093976928, 4019.598040195957, 4025.4565633639086, 4031.5162180538523, 4040.9797951010055, 5707.714614269353, 5719.714014299351, 5727.140928860537, 5727.627704199213, 5745.368009519033, 5469.371022332482, 5538.335399752055, 5560.998040705424, 5574.080276754452, 5620.943790562042, 5529.778808847601, 5531.612787105025, 5535.640183388067, 5540.7783688652, 5603.131514615241, 5231.790728370823, 5271.393789714232, 5444.373897001896, 5465.7813687453645, 5548.528375088163, 5547.0, 5557.722113894209, 5561.443855614406, 5571.164325351229, 5576.191452239484, 5387.838364849061, 5440.347158341025, 5458.317710286215, 5520.641158324696, 5528.51216952365], "value": 4217.993315843879, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.4374409785198, 809.951402915825, 826.177952936828, 838.5807096451774, 858.5363903492115, 14677.41290348386, 15680.52958411248, 15689.52931412058, 15816.44642437515, 15868.0, 14407.42370305189, 14547.127172369665, 14736.115833050024, 14751.336189871454, 14757.704845903076, 806.8507326144668, 826.7437094500694, 837.1210229259284, 837.7738010737097, 838.1450920061534, 659.1793217444289, 804.2801692485223, 836.017679226909, 838.7944953486374, 839.1273076000982, 864.1660797330575, 867.4578388507183, 873.6068769053951, 873.8863947686792, 877.5656050255133, 857.755539671197, 858.1761508951414, 858.6307887608326, 859.3297228162044, 859.7377799771067, 507.94158671752854, 619.7273199792077, 630.4168644004324, 632.6235889645653, 633.9017452294902, 14536.200508972002, 15161.696766064728, 15181.620459488491, 15190.316435760307, 15218.847811521853, 14070.859291407058, 14072.92963535186, 14359.928200359036, 14511.0, 14568.125912445286, 13195.538156164585, 13258.734825303536, 13364.799528007088, 13395.531156409479, 13562.389692463863, 4465.843695470676, 4480.977595112004, 4506.1663592235545, 4570.291604801261, 4602.0, 76368.61815690942, 76401.61799191024, 76698.23301766967, 78055.21944780536, 79587.60206198989, 11619.477123529461, 11681.76636467266, 11711.355875426763, 11718.88281117178, 11904.821427678591, 22456.32631021072, 22470.32589022332, 22484.437889052577, 22799.31602051941, 22856.771432285797, 8627.78430539229, 8692.434991725644, 8771.342149338825, 8894.0, 8899.911000890037, 4759.16714574948, 4818.494058123917, 4866.7566621668775, 4871.878203044952, 4977.676451030671, 3405.387030334514, 3468.8785892493643, 3473.9925421627445, 3478.3738926993383, 3496.2133519958315, 619.3899009475663, 619.9907001394982, 622.8411755002445, 642.6047980491963, 644.0275184471388, 566.5863919338906, 615.9384061593894, 635.3900255754528, 644.7936660268763, 656.8456412743002, 9044.728658140266, 9282.118198771106, 9366.812663746687, 9544.42733435996, 9571.1864491519, 619.9690015499207, 642.3480167629859, 643.8004218692221, 657.8815813153583, 676.4047638078558, 4231.505865453692, 4473.284274516127, 4516.548345165523, 4542.500324964251, 4589.58693717567, 121745.0, 122290.3885480567, 123057.0, 124740.37629811793, 124861.0, 106446.0, 107683.0, 110200.0, 111840.0, 113520.43239783749, 76556.23443765602, 77123.61438192773, 86223.0, 87126.56436717777, 89538.0, 9191.480871864094, 9359.251259899327, 9554.187894029086, 9943.651972180938, 10220.0, 37448.812755936044, 43984.560154398045, 51225.74387128041, 51299.74350128225, 53739.19391209213, 64663.0, 67148.6642566784, 70945.0, 72417.6379118101, 73279.26720732724, 11660.53357865676, 12137.939310303393, 12303.384830758605, 12442.37788110609, 12532.122751407314, 13902.374393152535, 13994.300284985913, 14099.365528551034, 14356.569302920929, 14675.0, 12845.67885802825, 12988.870111298766, 13212.801807973081, 13611.591652250449, 14573.344199511259, 13592.524261650795, 13965.301734913417, 14440.422383104558, 14918.701625967204, 14954.0, 12466.5013399463, 12910.67723306925, 13038.152520086163, 13204.339783011003, 13343.0, 11427.0, 11580.536778528765, 11710.707232318919, 11727.530898764295, 11734.178607497393, 11157.49791259379, 11401.491671832184, 11489.08087352993, 11507.0, 11680.47437865315], "value": 7595.995610572424, "unit": "score"}], "name": "dromaeo_css", "value": 7207.745425986924, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 109.0, 111.0, 111.0, 109.0, 111.0, 110.0, 109.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 123.0, 125.0, 179.0, 118.0, 119.0, 143.0, 119.0, 159.0, 119.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 168.0, 160.0, 163.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 113.0, 75.0, 76.0, 74.0, 74.0, 100.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 127.0, 84.0, 84.0, 84.0, 121.0, 84.0, 83.0, 131.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 51.0, 53.0, 53.0, 51.0, 53.0, 51.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 67.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 76.0, 75.0, 85.0, 83.0, 76.0, 75.0, 74.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 118.0, 124.0, 118.0, 126.0, 117.0, 131.0, 120.0, 172.0, 133.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 153.0, 155.0, 154.0, 161.0, 157.0, 156.0, 153.0, 159.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 62.0, 61.0, 65.0, 61.0, 61.0, 61.0, 61.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1479.1, "alertThreshold": 2.0}]} 06:10:37 INFO - Return code: 0 06:10:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:10:37 INFO - # TBPL SUCCESS # 06:10:37 INFO - Running post-action listener: _resource_record_post_action 06:10:37 INFO - [mozharness: 2016-07-24 13:10:37.400871Z] Finished run-tests step (success) 06:10:37 INFO - Running post-run listener: _resource_record_post_run 06:10:37 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 151552; Write bytes: 310206464; Read time: 280; Write time: 245908 06:10:37 INFO - TinderboxPrint: CPU usage
13.0% 06:10:37 INFO - TinderboxPrint: I/O read bytes / time
151,552 / 280 06:10:37 INFO - TinderboxPrint: I/O write bytes / time
310,206,464 / 245,908 06:10:37 INFO - TinderboxPrint: CPU idle
8,278.6 (87.0%) 06:10:37 INFO - TinderboxPrint: CPU user
1,191.3 (12.5%) 06:10:37 INFO - TinderboxPrint: Swap in / out
0 / 0 06:10:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13926400; Read time: 0; Write time: 2936 06:10:37 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 147456; Write bytes: 296280064; Read time: 260; Write time: 242972 06:10:38 INFO - Running post-run listener: _upload_blobber_files 06:10:38 INFO - Blob upload gear active. 06:10:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:10:38 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 06:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:10:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:10:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:10:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:10:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:52 INFO - (blobuploader) - INFO - Done attempting. 06:10:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:10:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:10:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:53 INFO - (blobuploader) - INFO - Done attempting. 06:10:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:10:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:10:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:54 INFO - (blobuploader) - INFO - Done attempting. 06:10:54 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:54 INFO - Return code: 0 06:10:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:10:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ba6f52e8e528caae65d6507e7a83889f2b9a96cb9e90cde0406576ca3e6fd6b9fec8d83dcccb4a7404e593ef67d0dbccaf8783cd455921812e6dfdf048c551b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f1acb8f951f83705f7c40cbbc202909502a7666016304ba919dee8167050857584e1fa59abcc600cbf5fdf07551185a803a8e7a811fb1ebcb89b358bbf475ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f70f2038efbd292bad7d0cbca6faa3a8c9bdf85241874511061f8c8e004a9c4ab3f430e15801b0495ef763b9f289d7f943d9b9dd6048fe90aafbadc267d979"} 06:10:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:10:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:10:54 INFO - Contents: 06:10:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ba6f52e8e528caae65d6507e7a83889f2b9a96cb9e90cde0406576ca3e6fd6b9fec8d83dcccb4a7404e593ef67d0dbccaf8783cd455921812e6dfdf048c551b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f1acb8f951f83705f7c40cbbc202909502a7666016304ba919dee8167050857584e1fa59abcc600cbf5fdf07551185a803a8e7a811fb1ebcb89b358bbf475ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f70f2038efbd292bad7d0cbca6faa3a8c9bdf85241874511061f8c8e004a9c4ab3f430e15801b0495ef763b9f289d7f943d9b9dd6048fe90aafbadc267d979"} 06:10:54 INFO - Running post-run listener: copy_logs_to_upload_dir 06:10:54 INFO - Copying logs to upload dir... 06:10:54 INFO - mkdir: /builds/slave/test/build/upload/logs 06:10:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.656004 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-24 06:10:54.414530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-24 06:10:54.417913) ========= 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=1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ba6f52e8e528caae65d6507e7a83889f2b9a96cb9e90cde0406576ca3e6fd6b9fec8d83dcccb4a7404e593ef67d0dbccaf8783cd455921812e6dfdf048c551b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f1acb8f951f83705f7c40cbbc202909502a7666016304ba919dee8167050857584e1fa59abcc600cbf5fdf07551185a803a8e7a811fb1ebcb89b358bbf475ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f70f2038efbd292bad7d0cbca6faa3a8c9bdf85241874511061f8c8e004a9c4ab3f430e15801b0495ef763b9f289d7f943d9b9dd6048fe90aafbadc267d979"} build_url:https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/esexG4UrSJiYWCM6_cX-9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ba6f52e8e528caae65d6507e7a83889f2b9a96cb9e90cde0406576ca3e6fd6b9fec8d83dcccb4a7404e593ef67d0dbccaf8783cd455921812e6dfdf048c551b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f1acb8f951f83705f7c40cbbc202909502a7666016304ba919dee8167050857584e1fa59abcc600cbf5fdf07551185a803a8e7a811fb1ebcb89b358bbf475ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f70f2038efbd292bad7d0cbca6faa3a8c9bdf85241874511061f8c8e004a9c4ab3f430e15801b0495ef763b9f289d7f943d9b9dd6048fe90aafbadc267d979"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-24 06:10:54.443842) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 06:10:54.444212) ========= 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=1f5564757af27664ca02d71f000001b0-1469357531.536981-910266474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 06:10:54.528830) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-24 06:10:54.529327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-24 06:10:54.529802) ========= ========= Total master_lag: 0.21 =========