builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1468505236.71 results: success (0) buildid: 20160714043035 builduid: 415f6dd0ad8f4474a060dfaa68839fc3 revision: 08f8a5aacd8308a73f6040fe522be7ba38497561 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:16.707518) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:16.707988) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:16.708263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:16.723485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:16.723873) ========= 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=ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 07:07:17-- 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% 69.2M=0s 2016-07-14 07:07:17 (69.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115762 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:16.853737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:16.854103) ========= 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=ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023785 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:16.904361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:16.904766) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 08f8a5aacd8308a73f6040fe522be7ba38497561 --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 08f8a5aacd8308a73f6040fe522be7ba38497561 --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=ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 07:07:17,266 truncating revision to first 12 chars 2016-07-14 07:07:17,267 Setting DEBUG logging. 2016-07-14 07:07:17,267 attempt 1/10 2016-07-14 07:07:17,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/08f8a5aacd83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 07:07:17,586 unpacking tar archive at: mozilla-central-08f8a5aacd83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.694177 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:17.612791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:17.613113) ========= script_repo_revision: 08f8a5aacd8308a73f6040fe522be7ba38497561 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:17.613527) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:17.613813) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 07:07:17.624704) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-14 07:07:17.625059) ========= /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=ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:07:18 INFO - MultiFileLogger online at 20160714 07:07:18 in /builds/slave/test 07:07:18 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 07:07:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:07:18 INFO - {'append_to_log': False, 07:07:18 INFO - 'base_work_dir': '/builds/slave/test', 07:07:18 INFO - 'blob_upload_branch': 'Firefox', 07:07:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:07:18 INFO - 'branch': 'Firefox', 07:07:18 INFO - 'buildbot_json_path': 'buildprops.json', 07:07:18 INFO - 'config_files': ('talos/linux_config.py',), 07:07:18 INFO - 'default_actions': ('clobber', 07:07:18 INFO - 'read-buildbot-config', 07:07:18 INFO - 'download-and-extract', 07:07:18 INFO - 'populate-webroot', 07:07:18 INFO - 'create-virtualenv', 07:07:18 INFO - 'install', 07:07:18 INFO - 'run-tests'), 07:07:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:07:18 INFO - 'download_minidump_stackwalk': True, 07:07:18 INFO - 'download_symbols': 'ondemand', 07:07:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:07:18 INFO - 'tooltool.py': '/tools/tooltool.py', 07:07:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:07:18 INFO - '/tools/misc-python/virtualenv.py')}, 07:07:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:07:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:07:18 INFO - 'installer_path': 'installer.exe', 07:07:18 INFO - 'log_level': 'info', 07:07:18 INFO - 'log_name': 'talos', 07:07:18 INFO - 'log_to_console': True, 07:07:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:07:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:07:18 INFO - 'opt_config_files': (), 07:07:18 INFO - 'pip_index': False, 07:07:18 INFO - 'sps_profile': False, 07:07:18 INFO - 'sps_profile_interval': 0, 07:07:18 INFO - 'suite': 'dromaeojs', 07:07:18 INFO - 'system_bits': '32', 07:07:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:07:18 INFO - 'title': 'talos-linux64-ix-035', 07:07:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:07:18 INFO - 'use_talos_json': True, 07:07:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:07:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:07:18 INFO - 'work_dir': 'build'} 07:07:18 INFO - ##### 07:07:18 INFO - ##### Running clobber step. 07:07:18 INFO - ##### 07:07:18 INFO - Running pre-action listener: _resource_record_pre_action 07:07:18 INFO - Running main action method: clobber 07:07:18 INFO - rmtree: /builds/slave/test/build 07:07:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:07:18 INFO - Running post-action listener: _resource_record_post_action 07:07:18 INFO - ##### 07:07:18 INFO - ##### Finished clobber step (success) 07:07:18 INFO - ##### 07:07:18 INFO - ##### 07:07:18 INFO - ##### Running read-buildbot-config step. 07:07:18 INFO - ##### 07:07:18 INFO - Running pre-action listener: _resource_record_pre_action 07:07:18 INFO - Running main action method: read_buildbot_config 07:07:18 INFO - Using buildbot properties: 07:07:18 INFO - { 07:07:18 INFO - "project": "", 07:07:18 INFO - "product": "firefox", 07:07:18 INFO - "script_repo_revision": "production", 07:07:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:07:18 INFO - "repository": "", 07:07:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:07:18 INFO - "buildid": "20160714043035", 07:07:18 INFO - "pgo_build": "True", 07:07:18 INFO - "basedir": "/builds/slave/test", 07:07:18 INFO - "buildnumber": 388, 07:07:18 INFO - "slavename": "talos-linux64-ix-035", 07:07:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:07:18 INFO - "platform": "ubuntu64_hw", 07:07:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:07:18 INFO - "branch": "mozilla-central", 07:07:18 INFO - "repo_path": "mozilla-central", 07:07:18 INFO - "revision": "08f8a5aacd8308a73f6040fe522be7ba38497561", 07:07:18 INFO - "stage_platform": "linux64-pgo", 07:07:18 INFO - "builduid": "415f6dd0ad8f4474a060dfaa68839fc3", 07:07:18 INFO - "slavebuilddir": "test" 07:07:18 INFO - } 07:07:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:07:18 INFO - Running post-action listener: _resource_record_post_action 07:07:18 INFO - ##### 07:07:18 INFO - ##### Finished read-buildbot-config step (success) 07:07:18 INFO - ##### 07:07:18 INFO - ##### 07:07:18 INFO - ##### Running download-and-extract step. 07:07:18 INFO - ##### 07:07:18 INFO - Running pre-action listener: _resource_record_pre_action 07:07:18 INFO - Running main action method: download_and_extract 07:07:18 INFO - mkdir: /builds/slave/test/build/tests 07:07: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')]} 07:07:18 INFO - https://queue.taskcluster.net/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:07:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:07:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:07:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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 07:07:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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 07:07:19 INFO - Downloaded 1361 bytes. 07:07:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:07:19 INFO - Using the following test package requirements: 07:07:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:07:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:07:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:07:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:19 INFO - u'jsshell-linux-x86_64.zip'], 07:07:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:07:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:07:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:07:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:07:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:07:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:07:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:07: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')]} 07:07:19 INFO - https://queue.taskcluster.net/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:07:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:07:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:07:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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 07:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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 07:07:20 INFO - Downloaded 24326630 bytes. 07:07:20 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'] 07:07:20 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 07:07:21 INFO - Return code: 0 07:07:21 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 07:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:21 INFO - https://queue.taskcluster.net/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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 07:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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 07:07:22 INFO - Downloaded 24326630 bytes. 07:07:22 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'] 07:07:22 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 07:07:24 INFO - Return code: 0 07:07: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')]} 07:07:24 INFO - https://queue.taskcluster.net/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:07:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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 07:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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 07:07:25 INFO - Downloaded 14403317 bytes. 07:07:25 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'] 07:07:25 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 07:07:25 INFO - Return code: 0 07:07: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')]} 07:07:25 INFO - https://queue.taskcluster.net/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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 07:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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 07:07:26 INFO - Downloaded 60803279 bytes. 07:07:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:07:26 INFO - mkdir: /builds/slave/test/properties 07:07:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:07:26 INFO - Writing to file /builds/slave/test/properties/build_url 07:07:26 INFO - Contents: 07:07:26 INFO - build_url:https://queue.taskcluster.net/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:07:27 INFO - Running post-action listener: _resource_record_post_action 07:07:27 INFO - Running post-action listener: set_extra_try_arguments 07:07:27 INFO - ##### 07:07:27 INFO - ##### Finished download-and-extract step (success) 07:07:27 INFO - ##### 07:07:27 INFO - ##### 07:07:27 INFO - ##### Running populate-webroot step. 07:07:27 INFO - ##### 07:07:27 INFO - Running pre-action listener: _resource_record_pre_action 07:07:27 INFO - Running main action method: populate_webroot 07:07:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:07:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:07:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:07:27 INFO - '--tppagecycles', 07:07:27 INFO - '7'], 07:07:27 INFO - 'tests': ['tsvgm']}}, 07:07:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:07:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:07:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:07:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:07:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:27 INFO - 'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:27 INFO - 'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['damp', 'tps']}, 07:07:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:27 INFO - 'tests': ['damp', 'tps']}, 07:07:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['dromaeo_dom']}, 07:07:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:07:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['basic_compositor_video']}, 07:07:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:07:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['a11yr', 07:07:27 INFO - 'ts_paint', 07:07:27 INFO - 'tpaint', 07:07:27 INFO - 'sessionrestore', 07:07:27 INFO - 'sessionrestore_no_auto_restore', 07:07:27 INFO - 'tabpaint']}, 07:07:27 INFO - 'other-e10s': {'tests': ['a11yr', 07:07:27 INFO - 'ts_paint', 07:07:27 INFO - 'tpaint', 07:07:27 INFO - 'sessionrestore', 07:07:27 INFO - 'sessionrestore_no_auto_restore', 07:07:27 INFO - 'tabpaint']}, 07:07:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:07:27 INFO - 'ts_paint', 07:07:27 INFO - 'tpaint', 07:07:27 INFO - 'sessionrestore', 07:07:27 INFO - 'sessionrestore_no_auto_restore', 07:07:27 INFO - 'tabpaint']}, 07:07:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:07:27 INFO - 'ts_paint', 07:07:27 INFO - 'tpaint', 07:07:27 INFO - 'sessionrestore', 07:07:27 INFO - 'sessionrestore_no_auto_restore', 07:07:27 INFO - 'tabpaint']}, 07:07:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['a11yr', 07:07:27 INFO - 'ts_paint', 07:07:27 INFO - 'tpaint', 07:07:27 INFO - 'sessionrestore', 07:07:27 INFO - 'sessionrestore_no_auto_restore', 07:07:27 INFO - 'tabpaint']}, 07:07:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['a11yr', 07:07:27 INFO - 'ts_paint', 07:07:27 INFO - 'tpaint', 07:07:27 INFO - 'sessionrestore', 07:07:27 INFO - 'sessionrestore_no_auto_restore', 07:07:27 INFO - 'tabpaint']}, 07:07:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['tsvgx', 07:07:27 INFO - 'tsvgr_opacity', 07:07:27 INFO - 'tart', 07:07:27 INFO - 'tscrollx', 07:07:27 INFO - 'cart']}, 07:07:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:07:27 INFO - 'tsvgr_opacity', 07:07:27 INFO - 'tart', 07:07:27 INFO - 'tscrollx', 07:07:27 INFO - 'cart']}, 07:07:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:27 INFO - 'talos_options': ['--disable-e10s'], 07:07:27 INFO - 'tests': ['tp5o']}, 07:07:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:27 INFO - 'tests': ['tp5o']}, 07:07:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:27 INFO - 'talos_options': ['--disable-e10s', 07:07:27 INFO - '--xperf_path', 07:07:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:27 INFO - 'tests': ['tp5n']}, 07:07:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:27 INFO - 'talos_options': ['--xperf_path', 07:07:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:27 INFO - 'tests': ['tp5n']}}, 07:07:27 INFO - 'talos.zip': {'path': '', 07:07:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:07:27 INFO - Running post-action listener: _resource_record_post_action 07:07:27 INFO - ##### 07:07:27 INFO - ##### Finished populate-webroot step (success) 07:07:27 INFO - ##### 07:07:27 INFO - ##### 07:07:27 INFO - ##### Running create-virtualenv step. 07:07:27 INFO - ##### 07:07:27 INFO - Running pre-action listener: _resource_record_pre_action 07:07:27 INFO - Running main action method: create_virtualenv 07:07:27 INFO - Creating virtualenv /builds/slave/test/build/venv 07:07:27 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 07:07:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:07:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:07:27 INFO - Using real prefix '/usr' 07:07:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:07:28 INFO - Installing distribute.............................................................................................................................................................................................done. 07:07:30 INFO - Installing pip.................done. 07:07:30 INFO - Return code: 0 07:07:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:30 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 0x148b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174a3b0>, '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 0x174b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', '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 07:07:30 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 07:07:30 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 07:07:30 INFO - Using env: {'DISPLAY': ':0', 07:07:30 INFO - 'HOME': '/home/cltbld', 07:07:30 INFO - 'LANG': 'en_US.UTF-8', 07:07:30 INFO - 'LANGUAGE': 'en_US:en', 07:07:30 INFO - 'LOGNAME': 'cltbld', 07:07:30 INFO - 'MAIL': '/var/mail/cltbld', 07:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:30 INFO - 'MOZ_NO_REMOTE': '1', 07:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:30 INFO - 'NO_EM_RESTART': '1', 07:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:30 INFO - 'PWD': '/builds/slave/test', 07:07:30 INFO - 'SHELL': '/bin/bash', 07:07:30 INFO - 'SHLVL': '1', 07:07:30 INFO - 'TERM': 'linux', 07:07:30 INFO - 'TMOUT': '86400', 07:07:30 INFO - 'USER': 'cltbld', 07:07:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', 07:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:30 INFO - '_': '/tools/buildbot/bin/python'} 07:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:30 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 07:07:30 INFO - Cleaning up... 07:07:30 INFO - Return code: 0 07:07:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:30 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 0x148b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174a3b0>, '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 0x174b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', '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 07:07:30 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 07:07:30 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 07:07:30 INFO - Using env: {'DISPLAY': ':0', 07:07:30 INFO - 'HOME': '/home/cltbld', 07:07:30 INFO - 'LANG': 'en_US.UTF-8', 07:07:30 INFO - 'LANGUAGE': 'en_US:en', 07:07:30 INFO - 'LOGNAME': 'cltbld', 07:07:30 INFO - 'MAIL': '/var/mail/cltbld', 07:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:30 INFO - 'MOZ_NO_REMOTE': '1', 07:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:30 INFO - 'NO_EM_RESTART': '1', 07:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:30 INFO - 'PWD': '/builds/slave/test', 07:07:30 INFO - 'SHELL': '/bin/bash', 07:07:30 INFO - 'SHLVL': '1', 07:07:30 INFO - 'TERM': 'linux', 07:07:30 INFO - 'TMOUT': '86400', 07:07:30 INFO - 'USER': 'cltbld', 07:07:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', 07:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:30 INFO - '_': '/tools/buildbot/bin/python'} 07:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:30 INFO - Downloading/unpacking psutil>=3.1.1 07:07:30 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 07:07:30 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 07:07:30 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 07:07:30 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 07:07:30 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 07:07:30 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 07:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:07:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:32 INFO - Installing collected packages: psutil 07:07:32 INFO - Running setup.py install for psutil 07:07:32 INFO - building 'psutil._psutil_linux' extension 07:07:32 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 07:07:32 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 07:07:32 INFO - building 'psutil._psutil_posix' extension 07:07:32 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 07:07:32 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 07:07:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:33 INFO - Successfully installed psutil 07:07:33 INFO - Cleaning up... 07:07:33 INFO - Return code: 0 07:07:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:07: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')]} 07:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174a3b0>, '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 0x174b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', '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 07:07: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:07: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 mozsystemmonitor==0.3 07:07:33 INFO - Using env: {'DISPLAY': ':0', 07:07:33 INFO - 'HOME': '/home/cltbld', 07:07:33 INFO - 'LANG': 'en_US.UTF-8', 07:07:33 INFO - 'LANGUAGE': 'en_US:en', 07:07:33 INFO - 'LOGNAME': 'cltbld', 07:07:33 INFO - 'MAIL': '/var/mail/cltbld', 07:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:33 INFO - 'MOZ_NO_REMOTE': '1', 07:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:33 INFO - 'NO_EM_RESTART': '1', 07:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:33 INFO - 'PWD': '/builds/slave/test', 07:07:33 INFO - 'SHELL': '/bin/bash', 07:07:33 INFO - 'SHLVL': '1', 07:07:33 INFO - 'TERM': 'linux', 07:07:33 INFO - 'TMOUT': '86400', 07:07:33 INFO - 'USER': 'cltbld', 07:07:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', 07:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:33 INFO - '_': '/tools/buildbot/bin/python'} 07:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:07:35 INFO - Installing collected packages: mozsystemmonitor 07:07:35 INFO - Running setup.py install for mozsystemmonitor 07:07:35 INFO - Successfully installed mozsystemmonitor 07:07:35 INFO - Cleaning up... 07:07:35 INFO - Return code: 0 07:07:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:07:35 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')]} 07:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:35 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')]} 07:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:35 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 0x148b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174a3b0>, '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 0x174b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', '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 07:07:35 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 07:07:35 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 07:07:35 INFO - Using env: {'DISPLAY': ':0', 07:07:35 INFO - 'HOME': '/home/cltbld', 07:07:35 INFO - 'LANG': 'en_US.UTF-8', 07:07:35 INFO - 'LANGUAGE': 'en_US:en', 07:07:35 INFO - 'LOGNAME': 'cltbld', 07:07:35 INFO - 'MAIL': '/var/mail/cltbld', 07:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:35 INFO - 'MOZ_NO_REMOTE': '1', 07:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:35 INFO - 'NO_EM_RESTART': '1', 07:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:35 INFO - 'PWD': '/builds/slave/test', 07:07:35 INFO - 'SHELL': '/bin/bash', 07:07:35 INFO - 'SHLVL': '1', 07:07:35 INFO - 'TERM': 'linux', 07:07:35 INFO - 'TMOUT': '86400', 07:07:35 INFO - 'USER': 'cltbld', 07:07:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', 07:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:35 INFO - '_': '/tools/buildbot/bin/python'} 07:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:35 INFO - Downloading/unpacking jsonschema==2.5.1 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:07:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:37 INFO - Downloading functools32-3.2.3-2.tar.gz 07:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:07:37 INFO - warning: no files found matching '*.txt' 07:07:37 INFO - no previously-included directories found matching 'build' 07:07:37 INFO - no previously-included directories found matching 'dist' 07:07:37 INFO - no previously-included directories found matching '.git*' 07:07:37 INFO - Installing collected packages: jsonschema, functools32 07:07:37 INFO - Running setup.py install for functools32 07:07:38 INFO - warning: no files found matching '*.txt' 07:07:38 INFO - no previously-included directories found matching 'build' 07:07:38 INFO - no previously-included directories found matching 'dist' 07:07:38 INFO - no previously-included directories found matching '.git*' 07:07:38 INFO - Successfully installed jsonschema functools32 07:07:38 INFO - Cleaning up... 07:07:38 INFO - Return code: 0 07:07:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:38 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 0x148b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174a3b0>, '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 0x174b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', '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 07:07:38 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 07:07:38 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 07:07:38 INFO - Using env: {'DISPLAY': ':0', 07:07:38 INFO - 'HOME': '/home/cltbld', 07:07:38 INFO - 'LANG': 'en_US.UTF-8', 07:07:38 INFO - 'LANGUAGE': 'en_US:en', 07:07:38 INFO - 'LOGNAME': 'cltbld', 07:07:38 INFO - 'MAIL': '/var/mail/cltbld', 07:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:38 INFO - 'MOZ_NO_REMOTE': '1', 07:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:38 INFO - 'NO_EM_RESTART': '1', 07:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:38 INFO - 'PWD': '/builds/slave/test', 07:07:38 INFO - 'SHELL': '/bin/bash', 07:07:38 INFO - 'SHLVL': '1', 07:07:38 INFO - 'TERM': 'linux', 07:07:38 INFO - 'TMOUT': '86400', 07:07:38 INFO - 'USER': 'cltbld', 07:07:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', 07:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:38 INFO - '_': '/tools/buildbot/bin/python'} 07:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:38 INFO - Downloading/unpacking blobuploader==1.2.4 07:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:40 INFO - Downloading blobuploader-1.2.4.tar.gz 07:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:07:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:07:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:40 INFO - Downloading docopt-0.6.1.tar.gz 07:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:07:41 INFO - Installing collected packages: blobuploader, requests, docopt 07:07:41 INFO - Running setup.py install for blobuploader 07:07:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:07:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:07:41 INFO - Running setup.py install for requests 07:07:41 INFO - Running setup.py install for docopt 07:07:41 INFO - Successfully installed blobuploader requests docopt 07:07:41 INFO - Cleaning up... 07:07:41 INFO - Return code: 0 07:07:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:41 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 0x148b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174a3b0>, '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 0x174b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', '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 07:07:41 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 07:07:41 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 07:07:41 INFO - Using env: {'DISPLAY': ':0', 07:07:41 INFO - 'HOME': '/home/cltbld', 07:07:41 INFO - 'LANG': 'en_US.UTF-8', 07:07:41 INFO - 'LANGUAGE': 'en_US:en', 07:07:41 INFO - 'LOGNAME': 'cltbld', 07:07:41 INFO - 'MAIL': '/var/mail/cltbld', 07:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:41 INFO - 'MOZ_NO_REMOTE': '1', 07:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:41 INFO - 'NO_EM_RESTART': '1', 07:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:41 INFO - 'PWD': '/builds/slave/test', 07:07:41 INFO - 'SHELL': '/bin/bash', 07:07:41 INFO - 'SHLVL': '1', 07:07:41 INFO - 'TERM': 'linux', 07:07:41 INFO - 'TMOUT': '86400', 07:07:41 INFO - 'USER': 'cltbld', 07:07:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', 07:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:41 INFO - '_': '/tools/buildbot/bin/python'} 07:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:07:41 INFO - Running setup.py (path:/tmp/pip-Hsrw7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:07:41 INFO - Running setup.py (path:/tmp/pip-SwoA6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:07:42 INFO - Running setup.py (path:/tmp/pip-roc1hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:07:42 INFO - Running setup.py (path:/tmp/pip-3uX4D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:07:42 INFO - Running setup.py (path:/tmp/pip-7_bAlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:07:42 INFO - Running setup.py (path:/tmp/pip-9gE6bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:07:42 INFO - Running setup.py (path:/tmp/pip-4Rrwkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:07:42 INFO - Running setup.py (path:/tmp/pip-2IlqlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:07:42 INFO - Running setup.py (path:/tmp/pip-HCTGPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:07:42 INFO - Running setup.py (path:/tmp/pip-t14lrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:07:42 INFO - Running setup.py (path:/tmp/pip-_eg7cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:07:42 INFO - Running setup.py (path:/tmp/pip-5eETyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:07:42 INFO - Running setup.py (path:/tmp/pip-PruaDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:07:42 INFO - Running setup.py (path:/tmp/pip-T3_XsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:42 INFO - Running setup.py (path:/tmp/pip-jPHrVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:07:42 INFO - Running setup.py (path:/tmp/pip-avym1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:07:43 INFO - Running setup.py (path:/tmp/pip-86Ebqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:07:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:07:43 INFO - Running setup.py install for manifestparser 07:07:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:07:43 INFO - Running setup.py install for mozcrash 07:07:43 INFO - Running setup.py install for mozdebug 07:07:43 INFO - Running setup.py install for mozdevice 07:07:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:07:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:07:43 INFO - Running setup.py install for mozfile 07:07:43 INFO - Running setup.py install for mozhttpd 07:07:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:07:43 INFO - Running setup.py install for mozinfo 07:07:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:07:43 INFO - Running setup.py install for mozInstall 07:07:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:07:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:07:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:07:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:07:43 INFO - Running setup.py install for mozleak 07:07:44 INFO - Running setup.py install for mozlog 07:07:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:07:44 INFO - Running setup.py install for moznetwork 07:07:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:07:44 INFO - Running setup.py install for mozprocess 07:07:44 INFO - Running setup.py install for mozprofile 07:07:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:07:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:07:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:07:44 INFO - Running setup.py install for mozrunner 07:07:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:07:44 INFO - Running setup.py install for mozscreenshot 07:07:44 INFO - Running setup.py install for moztest 07:07:44 INFO - Running setup.py install for mozversion 07:07:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:07:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:07:44 INFO - Cleaning up... 07:07:44 INFO - Return code: 0 07:07:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07: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')]} 07:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:44 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 0x148b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174a3b0>, '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 0x174b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', '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 07:07:44 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 07:07:44 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 07:07:44 INFO - Using env: {'DISPLAY': ':0', 07:07:44 INFO - 'HOME': '/home/cltbld', 07:07:44 INFO - 'LANG': 'en_US.UTF-8', 07:07:44 INFO - 'LANGUAGE': 'en_US:en', 07:07:44 INFO - 'LOGNAME': 'cltbld', 07:07:44 INFO - 'MAIL': '/var/mail/cltbld', 07:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:44 INFO - 'MOZ_NO_REMOTE': '1', 07:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:44 INFO - 'NO_EM_RESTART': '1', 07:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:44 INFO - 'PWD': '/builds/slave/test', 07:07:44 INFO - 'SHELL': '/bin/bash', 07:07:44 INFO - 'SHLVL': '1', 07:07:44 INFO - 'TERM': 'linux', 07:07:44 INFO - 'TMOUT': '86400', 07:07:44 INFO - 'USER': 'cltbld', 07:07:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', 07:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:44 INFO - '_': '/tools/buildbot/bin/python'} 07:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:07:45 INFO - Running setup.py (path:/tmp/pip-MwzLCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:07:45 INFO - Running setup.py (path:/tmp/pip-YbGsze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:07:45 INFO - Running setup.py (path:/tmp/pip-5N8lAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:07:45 INFO - Running setup.py (path:/tmp/pip-7AkXRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:07:45 INFO - Running setup.py (path:/tmp/pip-qzDfQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:07:45 INFO - Running setup.py (path:/tmp/pip-zicWDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:07:45 INFO - Running setup.py (path:/tmp/pip-jaexXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:07:45 INFO - Running setup.py (path:/tmp/pip-wcKupG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:07:45 INFO - Running setup.py (path:/tmp/pip-UlnOaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:07:45 INFO - Running setup.py (path:/tmp/pip-AE77Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:07:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:07:45 INFO - Running setup.py (path:/tmp/pip-JeDDvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:07:45 INFO - Running setup.py (path:/tmp/pip-dn0rjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:07:45 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)) 07:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:07:45 INFO - Running setup.py (path:/tmp/pip-yGl0z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:07:46 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)) 07:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:07:46 INFO - Running setup.py (path:/tmp/pip-KPg948-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:07:46 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)) 07:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:46 INFO - Running setup.py (path:/tmp/pip-u4qzhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:46 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)) 07:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:07:46 INFO - Running setup.py (path:/tmp/pip-okRN9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:07:46 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)) 07:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:07:46 INFO - Running setup.py (path:/tmp/pip-wC0i5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:07:46 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)) 07:07:46 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)) 07:07:46 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)) 07:07:46 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)) 07:07:46 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)) 07:07:46 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)) 07:07:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:48 INFO - Downloading blessings-1.6.tar.gz 07:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:07:48 INFO - Installing collected packages: blessings 07:07:48 INFO - Running setup.py install for blessings 07:07:48 INFO - Successfully installed blessings 07:07:48 INFO - Cleaning up... 07:07:48 INFO - Return code: 0 07:07:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:07:48 INFO - Reading from file tmpfile_stdout 07:07:48 INFO - Current package versions: 07:07:48 INFO - argparse == 1.2.1 07:07:48 INFO - blessings == 1.6 07:07:48 INFO - blobuploader == 1.2.4 07:07:48 INFO - docopt == 0.6.1 07:07:48 INFO - functools32 == 3.2.3-2 07:07:48 INFO - jsonschema == 2.5.1 07:07:48 INFO - manifestparser == 1.1 07:07:48 INFO - mozInstall == 1.12 07:07:48 INFO - mozcrash == 0.17 07:07:48 INFO - mozdebug == 0.1 07:07:48 INFO - mozdevice == 0.48 07:07:48 INFO - mozfile == 1.2 07:07:48 INFO - mozhttpd == 0.7 07:07:48 INFO - mozinfo == 0.9 07:07:48 INFO - mozleak == 0.1 07:07:48 INFO - mozlog == 3.2 07:07:48 INFO - moznetwork == 0.27 07:07:48 INFO - mozprocess == 0.23 07:07:48 INFO - mozprofile == 0.28 07:07:48 INFO - mozrunner == 6.12 07:07:48 INFO - mozscreenshot == 0.1 07:07:48 INFO - mozsystemmonitor == 0.3 07:07:48 INFO - moztest == 0.7 07:07:48 INFO - mozversion == 1.4 07:07:48 INFO - psutil == 3.1.1 07:07:48 INFO - requests == 1.2.3 07:07:48 INFO - wsgiref == 0.1.2 07:07:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:48 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')]} 07:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:48 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')]} 07:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:48 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 0x148b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174a3b0>, '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 0x174b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', '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 07:07:48 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 07:07:48 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 07:07:48 INFO - Using env: {'DISPLAY': ':0', 07:07:48 INFO - 'HOME': '/home/cltbld', 07:07:48 INFO - 'LANG': 'en_US.UTF-8', 07:07:48 INFO - 'LANGUAGE': 'en_US:en', 07:07:48 INFO - 'LOGNAME': 'cltbld', 07:07:48 INFO - 'MAIL': '/var/mail/cltbld', 07:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:48 INFO - 'MOZ_NO_REMOTE': '1', 07:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:48 INFO - 'NO_EM_RESTART': '1', 07:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:48 INFO - 'PWD': '/builds/slave/test', 07:07:48 INFO - 'SHELL': '/bin/bash', 07:07:48 INFO - 'SHLVL': '1', 07:07:48 INFO - 'TERM': 'linux', 07:07:48 INFO - 'TMOUT': '86400', 07:07:48 INFO - 'USER': 'cltbld', 07:07:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', 07:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:48 INFO - '_': '/tools/buildbot/bin/python'} 07:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:48 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)) 07:07:48 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)) 07:07:48 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)) 07:07:48 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)) 07:07:48 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)) 07:07:48 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)) 07:07:48 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)) 07:07:48 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)) 07:07:48 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)) 07:07:48 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)) 07:07:48 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)) 07:07:48 INFO - Cleaning up... 07:07:48 INFO - Return code: 0 07:07:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:07:48 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')]} 07:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:48 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')]} 07:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:48 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 0x148b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174a3b0>, '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 0x174b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', '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 07:07:48 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 07:07:48 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 07:07:48 INFO - Using env: {'DISPLAY': ':0', 07:07:48 INFO - 'HOME': '/home/cltbld', 07:07:48 INFO - 'LANG': 'en_US.UTF-8', 07:07:48 INFO - 'LANGUAGE': 'en_US:en', 07:07:48 INFO - 'LOGNAME': 'cltbld', 07:07:48 INFO - 'MAIL': '/var/mail/cltbld', 07:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:48 INFO - 'MOZ_NO_REMOTE': '1', 07:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:48 INFO - 'NO_EM_RESTART': '1', 07:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:48 INFO - 'PWD': '/builds/slave/test', 07:07:48 INFO - 'SHELL': '/bin/bash', 07:07:48 INFO - 'SHLVL': '1', 07:07:48 INFO - 'TERM': 'linux', 07:07:48 INFO - 'TMOUT': '86400', 07:07:48 INFO - 'USER': 'cltbld', 07:07:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', 07:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:48 INFO - '_': '/tools/buildbot/bin/python'} 07:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:07:49 INFO - Cleaning up... 07:07:49 INFO - Return code: 0 07:07:49 INFO - Running post-action listener: _resource_record_post_action 07:07:49 INFO - Running post-action listener: _start_resource_monitoring 07:07:49 INFO - Starting resource monitoring. 07:07:49 INFO - ##### 07:07:49 INFO - ##### Finished create-virtualenv step (success) 07:07:49 INFO - ##### 07:07:49 INFO - ##### 07:07:49 INFO - ##### Running install step. 07:07:49 INFO - ##### 07:07:49 INFO - Running pre-action listener: _resource_record_pre_action 07:07:49 INFO - Running main action method: install 07:07:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:07:49 INFO - Reading from file tmpfile_stdout 07:07:49 INFO - Detecting whether we're running mozinstall >=1.0... 07:07:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:07:49 INFO - Reading from file tmpfile_stdout 07:07:49 INFO - Output received: 07:07:49 INFO - Usage: mozinstall [options] installer 07:07:49 INFO - Options: 07:07:49 INFO - -h, --help show this help message and exit 07:07:49 INFO - -d DEST, --destination=DEST 07:07:49 INFO - Directory to install application into. [default: 07:07:49 INFO - "/builds/slave/test"] 07:07:49 INFO - --app=APP Application being installed. [default: firefox] 07:07:49 INFO - mkdir: /builds/slave/test/build/application 07:07:49 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'] 07:07:49 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 07:08:06 INFO - Reading from file tmpfile_stdout 07:08:06 INFO - Output received: 07:08:06 INFO - /builds/slave/test/build/application/firefox/firefox 07:08:06 INFO - Running post-action listener: _resource_record_post_action 07:08:06 INFO - ##### 07:08:06 INFO - ##### Finished install step (success) 07:08:06 INFO - ##### 07:08:06 INFO - ##### 07:08:06 INFO - ##### Running run-tests step. 07:08:06 INFO - ##### 07:08:06 INFO - Running pre-action listener: _resource_record_pre_action 07:08:06 INFO - Running main action method: run_tests 07:08:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:08:06 INFO - Python 2.7.3 07:08:06 INFO - Return code: 0 07:08:06 INFO - grabbing minidump binary from tooltool 07:08:06 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')]} 07:08:06 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 0x174a3b0>, '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 0x174b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:08:06 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 07:08:06 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 07:08:06 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 07:08:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:08:06 INFO - Return code: 0 07:08:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:08:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:08:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:08:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:08:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:08:06 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/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:08:06 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/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 07:08:06 INFO - Using env: {'DISPLAY': ':0', 07:08:06 INFO - 'HOME': '/home/cltbld', 07:08:06 INFO - 'LANG': 'en_US.UTF-8', 07:08:06 INFO - 'LANGUAGE': 'en_US:en', 07:08:06 INFO - 'LOGNAME': 'cltbld', 07:08:06 INFO - 'MAIL': '/var/mail/cltbld', 07:08:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:08:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:06 INFO - 'MOZ_NO_REMOTE': '1', 07:08:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:06 INFO - 'NO_EM_RESTART': '1', 07:08:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:06 INFO - 'PWD': '/builds/slave/test', 07:08:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:08:06 INFO - 'SHELL': '/bin/bash', 07:08:06 INFO - 'SHLVL': '1', 07:08:06 INFO - 'TERM': 'linux', 07:08:06 INFO - 'TMOUT': '86400', 07:08:06 INFO - 'USER': 'cltbld', 07:08:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746', 07:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:06 INFO - '_': '/tools/buildbot/bin/python'} 07:08:06 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/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:08:06 INFO - mozversion application_buildid: 20160714043035 07:08:06 INFO - mozversion application_changeset: 08f8a5aacd8308a73f6040fe522be7ba38497561 07:08:06 INFO - mozversion application_display_name: Nightly 07:08:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:08:06 INFO - mozversion application_name: Firefox 07:08:06 INFO - mozversion application_remotingname: firefox 07:08:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:08:06 INFO - mozversion application_vendor: Mozilla 07:08:06 INFO - mozversion application_version: 50.0a1 07:08:06 INFO - mozversion platform_buildid: 20160714043035 07:08:06 INFO - mozversion platform_changeset: 08f8a5aacd8308a73f6040fe522be7ba38497561 07:08:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:08:06 INFO - mozversion platform_version: 50.0a1 07:08:06 INFO - using testdate: 1468505286 07:08:06 INFO - actual date: 1468505286 07:08:06 INFO - starting webserver on 'localhost:52391' 07:08:06 INFO - SUITE-START | Running 2 tests 07:08:06 INFO - TEST-START | dromaeo_css 07:08:06 INFO - operating with platform_type : linux_ 07:08:06 INFO - Initialising browser for dromaeo_css test... 07:08:06 INFO - TEST-INFO | started process 24450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2vitUf/profile http://localhost:52391/getInfo.html) 07:08:10 INFO - PROCESS | 24450 | __metrics Screen width/height:1600/1200 07:08:10 INFO - PROCESS | 24450 | colorDepth:24 07:08:10 INFO - PROCESS | 24450 | Browser inner width/height: 1024/697 07:08:10 INFO - PROCESS | 24450 | __metrics 07:08:11 INFO - PROCESS | 24450 | 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" 07:08:11 INFO - PROCESS | 24450 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:08:12 INFO - TEST-INFO | 24450: exit 0 07:08:12 INFO - Browser initialized. 07:08:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:08:12 INFO - TEST-INFO | started process 24533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2vitUf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:24 INFO - PROCESS | 24533 | RSS: Main: 157409280 07:08:24 INFO - PROCESS | 24533 | 07:09:15 INFO - PROCESS | 24533 | 1468505355824 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] 07:11:23 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:52391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52391/tests/dromaeo/cssquery-ext.html) 07:11:24 INFO - PROCESS | 24533 | RSS: Main: 290992128 07:11:24 INFO - PROCESS | 24533 | 07:14:27 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:52391/tests/dromaeo/cssquery-ext.html (next: http://localhost:52391/tests/dromaeo/cssquery-jquery.html) 07:14:27 INFO - PROCESS | 24533 | RSS: Main: 241729536 07:14:27 INFO - PROCESS | 24533 | 07:17:29 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:52391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52391/tests/dromaeo/cssquery-mootools.html) 07:17:30 INFO - PROCESS | 24533 | RSS: Main: 241483776 07:17:30 INFO - PROCESS | 24533 | 07:20:32 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:52391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52391/tests/dromaeo/cssquery-prototype.html) 07:20:33 INFO - PROCESS | 24533 | RSS: Main: 240238592 07:20:33 INFO - PROCESS | 24533 | 07:23:35 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:52391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52391/tests/dromaeo/cssquery-yui.html) 07:23:36 INFO - PROCESS | 24533 | RSS: Main: 229904384 07:23:36 INFO - PROCESS | 24533 | 07:26:39 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:52391/tests/dromaeo/cssquery-yui.html (next: http://localhost:52391/tests/dromaeo/cssquery-dojo.html) 07:26:39 INFO - PROCESS | 24533 | RSS: Main: 273870848 07:26:39 INFO - PROCESS | 24533 | 07:26:39 INFO - PROCESS | 24533 | __start_tp_report 07:26:39 INFO - PROCESS | 24533 | _x_x_mozilla_page_load 07:26:39 INFO - PROCESS | 24533 | _x_x_mozilla_page_load_details 07:26:39 INFO - PROCESS | 24533 | |i|pagename|runs| 07:26:39 INFO - PROCESS | 24533 | |0;dojo.html;3034.908952731418;3046.405950839587;3083.7224649781515;3086.9845650771745;3101.5502752100947;5256.632035757499;5291.973540132299;5297.417284098756;5398.379186393561;5427.511523962838;5278.3665960084845;5281.075811732951;5353.116735738598;5419.512243898049;5421;4726.858194254178;4809.927851082237;4822.6624136310475;4847.2971419144205;4966;4891.021795640868;4933.531314525132;4940.629452791055;4945.035718034985;4961.677490963094;4742.834000809972;4763.26169443735;4797.280407938802;4849.810702548257;4862.294967229732;4771.141194584973;4780.617550595944;4791;4853.174960256765;4929.950700492985;4767.7616119194245;4816.422029356465;4817.060673168733;4825.396825396825;4842.612590992712;5161.587073034186;5267.130923397634;5355.25026496287;5373.355197376301;5391.32608423947;5749.195112684228;5788.797392091299;5801.796937107223;5802.65184088956;5803.883922321572;5788.507976821975;5809.419058094199;5849.298084229919;5850.5612079094235;5851.356350801409;5198.090334191501;5244.8688782780355;5330.093884039761;5354.839354819362;5420.13277875538;5914.142449344821;5914.319853216849;5925.318588362394;5925.4370834770625;5932.733027013708;5629.549636029108;5634.887302253932;5670.971645141748;5671.801486947937;5682.346530149003;5547.7780888764;5615.129654903497;5673;5682.7442765075675;5731.853629274078;5652.0674088774895;5652.830415087554;5657.462541058593;5661.886762264731;5665.688387138664;5515.448455154533;5665.603407761417;5678.630888992202;5683;5707.600467967202;4284.871453856389;4296.699231053796;4313.482382114166;4346.760928148982;4405.603495685404;3888.241792850367;3889.0666240102173;3892.6885849132;3924.117073658404;3925.7644541327613;5361.758720857571;5399.271098401666;5401.864953376118;5404.189371594213;5416.91874621881;5455.5908306877145;5645.5201307888465;5650.773969041193;5672.234248376499;5734.971325143431;5412.91880621791;5422.267993820784;5423.728813559306;5424.403315635277;5424.674519528841;4659.697119687209;4785.808567657325;4788.688735232199;4799.592034677022;4835.0571638530855;5804.767809287666;5848.707564621837;5865.941340586625;5888.146218798251;5911.556633252523;5703.058995265735;5717.971410142923;5726.284214473191;5729.398413166724;5741.971290143522;5739.282589676291;5754.079347304411;5881.235439392852;5898.351181370132;5900.970495147497;5599.468050535193;5617.943820561742;5627.943720562906;5631.774729010794;5683.630564013326;5697.287839020122;5707.714614269353;5707.914381284201;5711.685857277889;5713.571482138939;5317.680939143664;5516.613837031369;5555.111182210827;5571.582131340085;5575.609707320448;5631.352394474524;5637.46444087811;5640.830775076754;5644.463775941279;5676.68778217202;5539.307586551681;5548.361938377138;5571.4428557143965;5574.777008919597;5583.35791383996;5455.618106732491;5536.252605898152;5600.383957764724;5604.971975140098;5665.716714164358;5377.623566350318;5435.374931882884;5442.183672449164;5478.616496845182;5485.259489968963 07:26:39 INFO - PROCESS | 24533 | |1;ext.html;580.5036693626948;613.9386061393858;620.987580248395;630.1115427247582;639.6354078175439;30633.846830765844;42958.785206074004;43213;43988;44008.3398749019;40902.7954860226;45818;45833;45880;45911.770441147746;8095.311898488636;8999.460032398061;9157.130072643089;9158.358914875962;10753.731156721065;10576.36541807494;10656.627018054369;10966.616168434106;10967.177461690406;10970.945145274263;10978;10983.890161098407;11025.779484410306;11035.944820275927;11041.558337666484;10921.344719316827;11004.339739615649;11018.724531886686;11032.889671103307;11036.282641628268;10944.507497162567;10992.560297588087;11012.889871101266;11017.173711971554;11018.11855051594;44450.55549444496;44732.3290150648;44754.32868506975;44779;44780.55219447829;3535.5934067582302;3547.2018795771005;3614.313280476701;3786.318462676717;3941.310270702644;33615.6638433615;34111.31777364439;34519.4822077669;35482.29035419277;35664;4229.577042295746;4232.746035237865;4253.74477531346;4259.893502662428;4321.2005778931;375485;377480;378092;378248.1087594572;379578;64888.02667959985;65563;65665.34334656592;65671;65710.34289657042;68485.65757171281;68538;68606.31393686098;68679.31320686729;68946.65526672435;15149.091054536762;15456.304466299043;15472.226388680521;15478.9226053869;15488.225588720745;12065.336406497552;12229.266244025386;12247.755044899051;12252.387380631111;12261.448234829453;15027.849721502864;18500.722489162672;20492.487687807923;20578.691319630216;20626.174953002013;6976.232614412411;7219.747308844166;7278;7410.96294518524;7542.094948606203;939.7603611079131;977.5405559387077;1015.8019186258756;1016.9949150254201;1126.9913427482356;32420;32466.32652042379;32725.67274327274;32835;33414.83292583522;1118.8321751737305;1121.1815374776295;1142.7885841119419;1156.5894107591853;1181.2971282087144;16850.32598696063;17151;17183.57041073983;17235.75939115133;17274.913625431793;533307;539339;539778;540414;542381;60255.69872150611;60934;61050.69474652598;61059;61101.38898611046;1220.6582156996055;1281.448976939906;1292.2634098563728;1319.3205499167937;1344.395022239996;32847.34305313833;33671.15822104467;33865;33921.32157356889;33998.74049120894;51952.740236298574;52743.73628131835;52823.73588132035;52877;52899.47100528945;421697;426059;429650;433093;433099;24971.87514062418;28035.719642804128;28213;28640.563132424242;29175.854120729262;48824.64520870402;49013.50986490232;49700.50299496959;49901;50222.74443138951;41042;42080.57919420889;42669.78665106655;43336.783316083216;43545.56454435415;42186.7890660557;42267.57732422637;42369.788151059045;42791.57208428001;43715.78142109269;41749.79125104355;41907.58092419037;42968.78515607527;43156.352654709575;43229.13541729085;35576.46635300421;36105.27789444144;36409.45385819162;37096.258074838894;37272.06819829526;27894.581581276703;27937.44125117527;28129;28197.295067623472;28204.294892627848 07:26:39 INFO - PROCESS | 24533 | |2;jquery.html;389.99415008774855;392.432934409778;395.1819733152376;401.4219523885605;413.23551429854774;13355.866441335584;18976.52558686032;20338.898305508472;20347.89826050868;20418.795812041913;15799.447019354326;19169.712454313198;19349;19925.302614408498;20025.799742002575;5648.435156484339;5807.709614519278;5814.651120932736;5814.941850581482;5826.563007774434;5760.913586296209;5800.883982320351;5810.970945145289;5855.297364316288;5907.793227237047;5691.8292451226525;5757.913631295513;5797.681127537984;5817.447342502455;5819.650820950736;5616.634918730269;5706.058500347438;5748.45389687979;5778.653280803165;5783.045797443417;5070.974645126787;5078.873028174288;5082.440931497532;5095.515925987025;5102.795888164469;23134.768652313596;23801;24177.03291868323;25107.121250756318;25172.24483265505;2472.7403622619727;2477.3930387055107;2560.8335458195156;2564.7948164146824;2809.6909339972585;14891.627709307246;15058.774118388234;15188.544343669708;15296.464623738117;15357.923210383988;1958.3243780895568;1977.416662084674;2018.4247489465579;2029.2593203480772;2063.886486243256;80692;85301.57349213277;85354.57322713347;86317.56841215817;86506;10165.593376265015;10521.473926303654;10551.84172237417;10649.787004259872;10980.341179529254;15034.548963531111;15179.089254644756;15247.466338678092;15274.541763747106;15277.388904443698;7746.961265193638;8062.677492900219;8080.151584083704;8139.877901831477;8152.103268640445;6766.83082922921;7647.617619119133;7716.151223365426;7761.573113478813;7818.8827167592535;6259.467945224706;6602.966985165043;6745.494087943423;6751.662416879137;6867.381935625817;1958.2069261948934;1972.142118178597;1978.1889425335544;2014.5467269864164;2043.4686981384948;1043.2905624175633;1096.572336788653;1098.3080659184664;1114.5318966034285;1125.1280257800106;19133.712994304817;20080.39758807238;20582.176712931316;20648.17407303721;20716.689249661267;1022.5756311130946;1028.8456731490187;1029.2383636109225;1063.962761303366;1115.4255558387438;11077.667669969753;11664.416779161009;11684.247362895634;11722.765544689059;11762.294262344287;238592;239438;240197;241366;492845;100457;109440;109617;109637.45181274043;109947.45026274817;998.3460833154296;1027.075631931253;1037.5953378182514;1040.193849766437;1048.2138396202847;17753.467395978143;17806.46580602584;18369.81630183681;18477.353292634692;18555.72166417532;30459.2385190372;37395.2520949574;40423.7978810104;45471;46810.76594617005;64782;65100.34899650943;65347;66064.33935660582;66200.66899665471;8717.433366831136;8727.694530691395;8773.078826723358;8856;9105.226055785333;10514.684559463229;12618.747625047632;13994.510192143227;14049.578512644637;14050.718985620026;11578.36319002463;12001.81997270059;12223;12260.816087758869;12445.937770311453;10564.418956957441;11704.298794940314;12078.154529182873;12274.631761047183;12364.319962402154;12010.819837702267;12046.277223366626;12304.938475307566;12375.814362784746;12645.557405490763;8279.130691277329;8379.45533540318;8471.66113355459;8773.034966153846;8887.955770172766;10209.336393134423;11736.002439792714;12040.75918481608;12382;12492.06309526771 07:26:39 INFO - PROCESS | 24533 | |3;mootools.html;1314.0538812055318;1407.2963518240877;1456.0171883978314;1536.231884057971;1750.2211515875433;8710.695125670603;9055.909440905589;9082.273418126559;9261.583228754705;9262.397944133643;9051.818963620724;9239;9255.722328330145;9258.814823703522;9276.953615231914;2058.084152552115;2313.3406979010983;2333.0900948630006;2358.5872472317274;2379.274321331993;2407.085307583116;2415.118481754165;2415.770501802326;2416.2871952773885;2418.613021916494;2294.804941579959;2302.815774738017;2302.827287953402;2303.1133013789645;2365.184011516033;2005.0977060322841;2196.9560608787892;2244.51742875281;2253.019936327703;2320.93037208884;2318.9072437102495;2354.023080421623;2359.622460406344;2374.299581623425;2379.7977171940406;9258.074192580756;9311.674091406836;9318.767030824216;9323.860142097874;9344.252459803267;5063.215201643751;5184.170532714747;5230.032443997872;5243.187305967581;5250.894982100336;3132.420502207076;3216.758743094254;3281.7210537104374;3299.7195238404765;3313.7017668409717;1141.303804679145;1169.4152923538231;1170.1453196683267;1177;1184.1059999700171;11894.82157767634;11896.702582435508;11903.345316007617;11908.761824763456;11921.165518413714;4413.3159360299205;4469.910601787946;4632.791524381411;4633.374494443275;4638.165130276515;10116.494175291205;10141.797164056678;10143.391396516232;10144.391336519833;10155.289129760993;5232.529072383504;5232.555232805178;5234.084035293885;5234.450382709837;5238.292830467914;4478.820847166142;4901.142300097468;5063.544281014726;5069.493050694901;5125.179971204664;4073.368627862686;4083.244599749056;4161.958380416218;4176.331786914079;4192.706510544293;1162.2561560601223;1223.3944197622234;1247.4511215065343;1290.11627035481;1308.9018323625767;1003.7039073473343;1008.996048931318;1011.4588695048114;1017.4149863828328;1028.0644613401769;6323;6324.6521441321165;6397.200349956255;6421.101045853584;6522.771702990372;961.5528779117604;970.7573106723319;972.4359871274644;998.2313618513849;1004.1213937804421;4054.432379466877;4121;4134.462519872397;4136;4160.812763425653;10478.161747060218;10805.513751881184;10888;10896.128309735202;10912.072473839813;10777.62278320255;10815.297005694605;10816.296940698829;10824.296420732628;10839.729006774895;8104.554249516334;8390.202930721573;8445.535495547803;8595.742127736054;8700.216980471789;6188.504919606511;6490.7079181436;6515.153030106056;6540.345965403421;6542.54202205841;10667.466626668791;10758.246922715334;10905.400202988912;10977.176711746491;11038.337699738042;10651.786964260826;10997.175211859303;11041.33751974884;11171.608993685182;11189.552417903193;8211.38414618894;8301.584920753818;8404.36967227448;8411.621477033426;8420.452670576638;8898.377113602244;8930.553472326228;8988.640454381752;8988.820223595621;9003.14470125337;6421.775237866652;7604.581748003913;7758.3017528422715;7873.37013038944;8380.07819139882;7989.9201007991505;8069.515829050276;8076.71731489395;8249.340052795882;8274.089850116603;7382.2617738225745;7394.815129621587;7475.327220550176;7502.287282708134;7510.774676759706;5313.760880760297;5340.172273297645;5340.893182136413;5389.83830485086;5417.702026388429;5282.102042652835;5320.414754377093;5428.755705993319;5446.727663616883;5481.260029895913 07:26:39 INFO - PROCESS | 24533 | |4;prototype.html;328.5646518363168;332.7422343541414;339.2130257801899;340.7001838382224;342.8217326989967;5203.609729270305;5262.421133675298;5332.866678333039;5387.622866399343;5389.356246344863;5320.654157479761;5322.946770532293;5325.387580428252;5330.653507522008;5363.892722145555;4128.463299771026;4167.229062623424;4178.582141785828;4190.53904070552;4194.8254488743205;3878;3980.8208630611693;4111.876643700693;4116.197341518405;4148.730332528391;4097.549269580359;4108.650764685005;4112.8971775705695;4125.381192821086;4128.236276288896;3957.8614748483665;4130.359794231899;4131.607497287753;4140.81366338514;4147.564505726886;3533.9293214135832;3560.2523470071055;3562.109472631842;3571.3750093733493;3591.3894637911358;5113.693178409308;5144.151215049513;5157.355330583677;5194.844154675366;5226.712530810804;4664.393628828265;4667.579917807379;4667.953320466786;4672.929906051412;4678.836240731558;5257.421683614799;5518.758279387146;5519.751611177507;5528.695921724304;5564.610477266593;4025.4766880305665;4043.3126368517424;4055.4119652650497;4062.0908173158864;4074.164796216798;5344.599155063386;5438;5718.628289161233;5759.308882934075;5771.682557459338;4168.8332466700995;4171.270027745193;4173.83304667816;4176.352665336878;4177.582241775798;4198.8110535026;4206.221848957953;4224.598663126998;4237.427947227085;4250.978745106317;4778.474367819537;4787.521247875255;4787.946651736613;4790.664653474223;4790.664653474293;5376.91934620981;5624.493795558419;5660.066089095253;5661.179129026268;5664.54683625309;1463.3780643226587;1465.934032968519;1467.2663668165917;1468.142799358812;1469.3828591991175;917.9495127767904;933.1399261264204;945.3004776465503;949.7435692363161;950.6435086842434;4802.495737947535;4804.231322988305;4809.831655892097;4816.638752093607;4878.219449900761;5076.6446348755235;5088.389393272831;5090.898182036339;5091.312672789126;5093.6247213252955;4660.300954856799;4830.7101573905675;4834.806607735652;4839.854804355875;4847.206533582597;2703.932401689934;2723.5233834079354;2724.209979106077;2728.4133911208787;2739.5890616407696;5137.818301790609;5231.55531779803;5239.29269548606;5244.685318880803;5280.81517146898;5000.9496106596125;5140.280360749498;5199.414178675464;5266.894662106736;5637.746301416446;5747.683877386784;5881.882362352729;5894.848380341059;5900.675462849585;5909.379515150933;5691.174779657009;5701.372848986691;5716.771329146787;5717.313922329347;5747.770089196385;5381.892362152813;5601.6639001658405;5614.382417934105;5631.746571404215;5650.773969041193;5850.707464626837;5853.619514731699;5874.325817142094;5881.32364778056;5884.382139875252;4195.769232692109;4203.726757760735;4219.683523735794;4221.915561688687;4224.746515209097;5489.698066606375;5708.771649133988;5715.799947001835;5734.598578099493;5744.971275143765;5530.253415788817;5573.693446860461;5574.554035677055;5582.385937546947;5583.581231407579;5304.283921670525;5509.972450137724;5535.391106978149;5558.388577256579;5586.441355864381;5466.34403871538;5481.095619222783;5502.862428439321;5506.513241424873;5515.917261241005;5524.309461317335;5579.442055794388;5589.832305030693;5627.8593035174445;5641.702408446163;5317.57459403239;5437.456254374689;5440.646357986719;5465.562754979513;5465.9726701366235 07:26:39 INFO - PROCESS | 24533 | |5;yui.html;719.3460490463216;752.7892190186747;763.1147868472573;767.8541077195332;813.6501304439096;15570.53288401347;16267.349306027745;16929.492115236564;16939.237734301954;16997.49007529773;15764;15870.444534441296;15924.601884952883;15972.84027159728;16047;681.4105798484325;796.7052190689453;800.7837883771364;826.2811354121923;827.2513375395276;820.3683163963774;830.3979614779297;830.6179157587517;831.6132998155856;832.0182185021672;870.8737233101197;874.8906386701663;875.8948926128874;876.0319846569545;876.3252295732283;707.2609123465965;838.279079991207;861.6854847980474;862.409249663979;863.2230992107154;626.890294198518;626.971786269619;627.0437582686394;627.4415769964735;627.8838414893214;14138.646533836736;14244.572662820132;14258.928705356408;14264.144151350953;14283.928580357031;13946.93026534871;14285.57143285703;14393.640158996004;14508.854911450855;14764.704705905822;13109.147905386119;13325.600231993056;13524.391402386917;13585.184888906697;13849.653758656013;4546.749928753918;4602.631789456836;4615.8153673853;4616.699914505546;4695.859124226278;79186.60406697987;79738.20261797424;80310;80728.59635701784;80938.59530702309;11137.331760094421;11401.714957125972;11422.942885285687;11486.425678716198;11609.245399049034;20619.381418557467;20928.581428371654;20936.267230646856;20986;21266.468338291357;8530.360222983301;8666.56667166639;8676.913230867736;8696.91303086961;8773.561321933877;4829.323894654751;4915.508449155127;4949.406071271471;4983.626228032912;5194.948050519522;3385.881494147693;3452.2922800825772;3476.60019097807;3492.2840817632323;3494.4583589543663;589.6579983609582;602.9577929544889;608.1091201389896;616.8057062025448;618.1469571990624;515.5051150895108;678.609799365357;704.3519961635308;783.8314762326128;796.1640277708383;9642.42145471274;10172.898271017342;10404.427756473468;10425.270231083903;10483.266171367932;669.9397054265042;670.33971538035;725.2095216214352;737.9298966598164;778.6457161991281;4835.734034628059;4840.515948405131;4857.8299759508245;4908.901821963541;4945.851624451272;109874;114551;116982;119624;121907;101894;104503.06766812348;105271.4736426313;105806;107443.46278268714;58657.41342586605;77415.2258477408;79368.20631793608;83926.58036709778;92639;10130.949345253226;10293.691479049958;10321.225908056776;10888.837133243971;11012.339259644446;37710;42917;53167.20249196343;53213.7339313301;54450;73777;75359;75868.24131758611;77813;80146;13220.074594778273;13271.800922985969;13323.533676321282;13341.132826366254;13509.324533773468;15248.652932643981;15557;15580;15653.530394088195;16214.918925405298;14054.508092216724;14177.14937103777;14290.28548572588;14594.343254553358;14711.632209194855;14545.92727036358;14779.556613301618;14784.260786960394;15209.695806083595;15247.16140612277;14320.427182912566;14421.7836732447;14462.566123016326;14526.782098268322;15071.321790519673;11404.7495716619;11417.31496110236;11431.977942820173;11848.686591284151;11889.762204756029;11851.585194518151;11910.583129590423;11915.2255103418;12073.57742479009;12144.817827732415 07:26:39 INFO - PROCESS | 24533 | __end_tp_report 07:26:39 INFO - PROCESS | 24533 | __start_cc_report 07:26:39 INFO - PROCESS | 24533 | _x_x_mozilla_cycle_collect,1122 07:26:39 INFO - PROCESS | 24533 | __end_cc_report 07:26:39 INFO - PROCESS | 24533 | __startTimestamp1468506399399__endTimestamp 07:26:39 INFO - PROCESS | 24533 | 07:26:39 INFO - PROCESS | 24533 | ------- Summary: start ------- 07:26:39 INFO - PROCESS | 24533 | Number of tests: 6 07:26:39 INFO - PROCESS | 24533 | 07:26:39 INFO - PROCESS | 24533 | [#0] dojo.html Cycles:165 Average:5293.83 Median:5485.26 stddev:610.23 (11.1%) stddev-sans-first:585.81 07:26:39 INFO - PROCESS | 24533 | Values: 3034.9 3046.4 3083.7 3087.0 3101.6 5256.6 5292.0 5297.4 5398.4 5427.5 5278.4 5281.1 5353.1 5419.5 5421.0 4726.9 4809.9 4822.7 4847.3 4966.0 4891.0 4933.5 4940.6 4945.0 4961.7 4742.8 4763.3 4797.3 4849.8 4862.3 4771.1 4780.6 4791.0 4853.2 4930.0 4767.8 4816.4 4817.1 4825.4 4842.6 5161.6 5267.1 5355.3 5373.4 5391.3 5749.2 5788.8 5801.8 5802.7 5803.9 5788.5 5809.4 5849.3 5850.6 5851.4 5198.1 5244.9 5330.1 5354.8 5420.1 5914.1 5914.3 5925.3 5925.4 5932.7 5629.5 5634.9 5671.0 5671.8 5682.3 5547.8 5615.1 5673.0 5682.7 5731.9 5652.1 5652.8 5657.5 5661.9 5665.7 5515.4 5665.6 5678.6 5683.0 5707.6 4284.9 4296.7 4313.5 4346.8 4405.6 3888.2 3889.1 3892.7 3924.1 3925.8 5361.8 5399.3 5401.9 5404.2 5416.9 5455.6 5645.5 5650.8 5672.2 5735.0 5412.9 5422.3 5423.7 5424.4 5424.7 4659.7 4785.8 4788.7 4799.6 4835.1 5804.8 5848.7 5865.9 5888.1 5911.6 5703.1 5718.0 5726.3 5729.4 5742.0 5739.3 5754.1 5881.2 5898.4 5901.0 5599.5 5617.9 5627.9 5631.8 5683.6 5697.3 5707.7 5707.9 5711.7 5713.6 5317.7 5516.6 5555.1 5571.6 5575.6 5631.4 5637.5 5640.8 5644.5 5676.7 5539.3 5548.4 5571.4 5574.8 5583.4 5455.6 5536.3 5600.4 5605.0 5665.7 5377.6 5435.4 5442.2 5478.6 5485.3 07:26:39 INFO - PROCESS | 24533 | 07:26:39 INFO - PROCESS | 24533 | [#1] ext.html Cycles:180 Average:61965.40 Median:378170.05 stddev:120055.48 (31.7%) stddev-sans-first:120303.80 07:26:39 INFO - PROCESS | 24533 | Values: 580.5 613.9 621.0 630.1 639.6 30633.8 42958.8 43213.0 43988.0 44008.3 40902.8 45818.0 45833.0 45880.0 45911.8 8095.3 8999.5 9157.1 9158.4 10753.7 10576.4 10656.6 10966.6 10967.2 10970.9 10978.0 10983.9 11025.8 11035.9 11041.6 10921.3 11004.3 11018.7 11032.9 11036.3 10944.5 10992.6 11012.9 11017.2 11018.1 44450.6 44732.3 44754.3 44779.0 44780.6 3535.6 3547.2 3614.3 3786.3 3941.3 33615.7 34111.3 34519.5 35482.3 35664.0 4229.6 4232.7 4253.7 4259.9 4321.2 375485.0 377480.0 378092.0 378248.1 379578.0 64888.0 65563.0 65665.3 65671.0 65710.3 68485.7 68538.0 68606.3 68679.3 68946.7 15149.1 15456.3 15472.2 15478.9 15488.2 12065.3 12229.3 12247.8 12252.4 12261.4 15027.8 18500.7 20492.5 20578.7 20626.2 6976.2 7219.7 7278.0 7411.0 7542.1 939.8 977.5 1015.8 1017.0 1127.0 32420.0 32466.3 32725.7 32835.0 33414.8 1118.8 1121.2 1142.8 1156.6 1181.3 16850.3 17151.0 17183.6 17235.8 17274.9 533307.0 539339.0 539778.0 540414.0 542381.0 60255.7 60934.0 61050.7 61059.0 61101.4 1220.7 1281.4 1292.3 1319.3 1344.4 32847.3 33671.2 33865.0 33921.3 33998.7 51952.7 52743.7 52823.7 52877.0 52899.5 421697.0 426059.0 429650.0 433093.0 433099.0 24971.9 28035.7 28213.0 28640.6 29175.9 48824.6 49013.5 49700.5 49901.0 50222.7 41042.0 42080.6 42669.8 43336.8 43545.6 42186.8 42267.6 42369.8 42791.6 43715.8 41749.8 41907.6 42968.8 43156.4 43229.1 35576.5 36105.3 36409.5 37096.3 37272.1 27894.6 27937.4 28129.0 28197.3 28204.3 07:26:39 INFO - PROCESS | 24533 | 07:26:39 INFO - PROCESS | 24533 | [#2] jquery.html Cycles:180 Average:24457.82 Median:11323.03 stddev:53339.90 (471.1%) stddev-sans-first:53458.92 07:26:39 INFO - PROCESS | 24533 | Values: 390.0 392.4 395.2 401.4 413.2 13355.9 18976.5 20338.9 20347.9 20418.8 15799.4 19169.7 19349.0 19925.3 20025.8 5648.4 5807.7 5814.7 5814.9 5826.6 5760.9 5800.9 5811.0 5855.3 5907.8 5691.8 5757.9 5797.7 5817.4 5819.7 5616.6 5706.1 5748.5 5778.7 5783.0 5071.0 5078.9 5082.4 5095.5 5102.8 23134.8 23801.0 24177.0 25107.1 25172.2 2472.7 2477.4 2560.8 2564.8 2809.7 14891.6 15058.8 15188.5 15296.5 15357.9 1958.3 1977.4 2018.4 2029.3 2063.9 80692.0 85301.6 85354.6 86317.6 86506.0 10165.6 10521.5 10551.8 10649.8 10980.3 15034.5 15179.1 15247.5 15274.5 15277.4 7747.0 8062.7 8080.2 8139.9 8152.1 6766.8 7647.6 7716.2 7761.6 7818.9 6259.5 6603.0 6745.5 6751.7 6867.4 1958.2 1972.1 1978.2 2014.5 2043.5 1043.3 1096.6 1098.3 1114.5 1125.1 19133.7 20080.4 20582.2 20648.2 20716.7 1022.6 1028.8 1029.2 1064.0 1115.4 11077.7 11664.4 11684.2 11722.8 11762.3 238592.0 239438.0 240197.0 241366.0 492845.0 100457.0 109440.0 109617.0 109637.5 109947.5 998.3 1027.1 1037.6 1040.2 1048.2 17753.5 17806.5 18369.8 18477.4 18555.7 30459.2 37395.3 40423.8 45471.0 46810.8 64782.0 65100.3 65347.0 66064.3 66200.7 8717.4 8727.7 8773.1 8856.0 9105.2 10514.7 12618.7 13994.5 14049.6 14050.7 11578.4 12001.8 12223.0 12260.8 12445.9 10564.4 11704.3 12078.2 12274.6 12364.3 12010.8 12046.3 12304.9 12375.8 12645.6 8279.1 8379.5 8471.7 8773.0 8888.0 10209.3 11736.0 12040.8 12382.0 12492.1 07:26:39 INFO - PROCESS | 24533 | 07:26:39 INFO - PROCESS | 24533 | [#3] mootools.html Cycles:180 Average:5961.05 Median:4303.01 stddev:3394.02 (78.9%) stddev-sans-first:3385.57 07:26:39 INFO - PROCESS | 24533 | Values: 1314.1 1407.3 1456.0 1536.2 1750.2 8710.7 9055.9 9082.3 9261.6 9262.4 9051.8 9239.0 9255.7 9258.8 9277.0 2058.1 2313.3 2333.1 2358.6 2379.3 2407.1 2415.1 2415.8 2416.3 2418.6 2294.8 2302.8 2302.8 2303.1 2365.2 2005.1 2197.0 2244.5 2253.0 2320.9 2318.9 2354.0 2359.6 2374.3 2379.8 9258.1 9311.7 9318.8 9323.9 9344.3 5063.2 5184.2 5230.0 5243.2 5250.9 3132.4 3216.8 3281.7 3299.7 3313.7 1141.3 1169.4 1170.1 1177.0 1184.1 11894.8 11896.7 11903.3 11908.8 11921.2 4413.3 4469.9 4632.8 4633.4 4638.2 10116.5 10141.8 10143.4 10144.4 10155.3 5232.5 5232.6 5234.1 5234.5 5238.3 4478.8 4901.1 5063.5 5069.5 5125.2 4073.4 4083.2 4162.0 4176.3 4192.7 1162.3 1223.4 1247.5 1290.1 1308.9 1003.7 1009.0 1011.5 1017.4 1028.1 6323.0 6324.7 6397.2 6421.1 6522.8 961.6 970.8 972.4 998.2 1004.1 4054.4 4121.0 4134.5 4136.0 4160.8 10478.2 10805.5 10888.0 10896.1 10912.1 10777.6 10815.3 10816.3 10824.3 10839.7 8104.6 8390.2 8445.5 8595.7 8700.2 6188.5 6490.7 6515.2 6540.3 6542.5 10667.5 10758.2 10905.4 10977.2 11038.3 10651.8 10997.2 11041.3 11171.6 11189.6 8211.4 8301.6 8404.4 8411.6 8420.5 8898.4 8930.6 8988.6 8988.8 9003.1 6421.8 7604.6 7758.3 7873.4 8380.1 7989.9 8069.5 8076.7 8249.3 8274.1 7382.3 7394.8 7475.3 7502.3 7510.8 5313.8 5340.2 5340.9 5389.8 5417.7 5282.1 5320.4 5428.8 5446.7 5481.3 07:26:39 INFO - PROCESS | 24533 | 07:26:39 INFO - PROCESS | 24533 | [#4] prototype.html Cycles:180 Average:4598.82 Median:5176.10 stddev:1337.32 (25.8%) stddev-sans-first:1302.09 07:26:39 INFO - PROCESS | 24533 | Values: 328.6 332.7 339.2 340.7 342.8 5203.6 5262.4 5332.9 5387.6 5389.4 5320.7 5322.9 5325.4 5330.7 5363.9 4128.5 4167.2 4178.6 4190.5 4194.8 3878.0 3980.8 4111.9 4116.2 4148.7 4097.5 4108.7 4112.9 4125.4 4128.2 3957.9 4130.4 4131.6 4140.8 4147.6 3533.9 3560.3 3562.1 3571.4 3591.4 5113.7 5144.2 5157.4 5194.8 5226.7 4664.4 4667.6 4668.0 4672.9 4678.8 5257.4 5518.8 5519.8 5528.7 5564.6 4025.5 4043.3 4055.4 4062.1 4074.2 5344.6 5438.0 5718.6 5759.3 5771.7 4168.8 4171.3 4173.8 4176.4 4177.6 4198.8 4206.2 4224.6 4237.4 4251.0 4778.5 4787.5 4787.9 4790.7 4790.7 5376.9 5624.5 5660.1 5661.2 5664.5 1463.4 1465.9 1467.3 1468.1 1469.4 917.9 933.1 945.3 949.7 950.6 4802.5 4804.2 4809.8 4816.6 4878.2 5076.6 5088.4 5090.9 5091.3 5093.6 4660.3 4830.7 4834.8 4839.9 4847.2 2703.9 2723.5 2724.2 2728.4 2739.6 5137.8 5231.6 5239.3 5244.7 5280.8 5000.9 5140.3 5199.4 5266.9 5637.7 5747.7 5881.9 5894.8 5900.7 5909.4 5691.2 5701.4 5716.8 5717.3 5747.8 5381.9 5601.7 5614.4 5631.7 5650.8 5850.7 5853.6 5874.3 5881.3 5884.4 4195.8 4203.7 4219.7 4221.9 4224.7 5489.7 5708.8 5715.8 5734.6 5745.0 5530.3 5573.7 5574.6 5582.4 5583.6 5304.3 5510.0 5535.4 5558.4 5586.4 5466.3 5481.1 5502.9 5506.5 5515.9 5524.3 5579.4 5589.8 5627.9 5641.7 5317.6 5437.5 5440.6 5465.6 5466.0 07:26:39 INFO - PROCESS | 24533 | 07:26:39 INFO - PROCESS | 24533 | [#5] yui.html Cycles:180 Average:21178.59 Median:3464.45 stddev:30289.47 (874.3%) stddev-sans-first:30335.49 07:26:39 INFO - PROCESS | 24533 | Values: 719.3 752.8 763.1 767.9 813.7 15570.5 16267.3 16929.5 16939.2 16997.5 15764.0 15870.4 15924.6 15972.8 16047.0 681.4 796.7 800.8 826.3 827.3 820.4 830.4 830.6 831.6 832.0 870.9 874.9 875.9 876.0 876.3 707.3 838.3 861.7 862.4 863.2 626.9 627.0 627.0 627.4 627.9 14138.6 14244.6 14258.9 14264.1 14283.9 13946.9 14285.6 14393.6 14508.9 14764.7 13109.1 13325.6 13524.4 13585.2 13849.7 4546.7 4602.6 4615.8 4616.7 4695.9 79186.6 79738.2 80310.0 80728.6 80938.6 11137.3 11401.7 11422.9 11486.4 11609.2 20619.4 20928.6 20936.3 20986.0 21266.5 8530.4 8666.6 8676.9 8696.9 8773.6 4829.3 4915.5 4949.4 4983.6 5194.9 3385.9 3452.3 3476.6 3492.3 3494.5 589.7 603.0 608.1 616.8 618.1 515.5 678.6 704.4 783.8 796.2 9642.4 10172.9 10404.4 10425.3 10483.3 669.9 670.3 725.2 737.9 778.6 4835.7 4840.5 4857.8 4908.9 4945.9 109874.0 114551.0 116982.0 119624.0 121907.0 101894.0 104503.1 105271.5 105806.0 107443.5 58657.4 77415.2 79368.2 83926.6 92639.0 10130.9 10293.7 10321.2 10888.8 11012.3 37710.0 42917.0 53167.2 53213.7 54450.0 73777.0 75359.0 75868.2 77813.0 80146.0 13220.1 13271.8 13323.5 13341.1 13509.3 15248.7 15557.0 15580.0 15653.5 16214.9 14054.5 14177.1 14290.3 14594.3 14711.6 14545.9 14779.6 14784.3 15209.7 15247.2 14320.4 14421.8 14462.6 14526.8 15071.3 11404.7 11417.3 11432.0 11848.7 11889.8 11851.6 11910.6 11915.2 12073.6 12144.8 07:26:39 INFO - PROCESS | 24533 | -------- Summary: end -------- 07:26:39 INFO - PROCESS | 24533 | 07:26:40 INFO - TEST-INFO | 24533: exit 0 07:26:40 INFO - TEST-OK | dromaeo_css | took 1113271ms 07:26:40 INFO - TEST-START | kraken 07:26:40 INFO - operating with platform_type : linux_ 07:26:40 INFO - Initialising browser for kraken test... 07:26:40 INFO - TEST-INFO | started process 24727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv3ivde/profile http://localhost:52391/getInfo.html) 07:26:43 INFO - PROCESS | 24727 | __metrics Screen width/height:1600/1200 07:26:43 INFO - PROCESS | 24727 | colorDepth:24 07:26:43 INFO - PROCESS | 24727 | Browser inner width/height: 1024/697 07:26:43 INFO - PROCESS | 24727 | __metrics 07:26:44 INFO - PROCESS | 24727 | 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" 07:26:44 INFO - PROCESS | 24727 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:26:45 INFO - TEST-INFO | 24727: exit 0 07:26:45 INFO - Browser initialized. 07:26:45 INFO - Running cycle 1/1 for kraken test... 07:26:45 INFO - TEST-INFO | started process 24809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv3ivde/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:57 INFO - PROCESS | 24809 | RSS: Main: 158089216 07:26:57 INFO - PROCESS | 24809 | 07:26:59 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52391/tests/kraken/driver.html?testName=audio-beat-detection) 07:27:00 INFO - PROCESS | 24809 | RSS: Main: 215810048 07:27:00 INFO - PROCESS | 24809 | 07:27:03 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52391/tests/kraken/driver.html?testName=audio-dft) 07:27:03 INFO - PROCESS | 24809 | RSS: Main: 204181504 07:27:03 INFO - PROCESS | 24809 | 07:27:07 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52391/tests/kraken/driver.html?testName=audio-fft) 07:27:07 INFO - PROCESS | 24809 | RSS: Main: 269893632 07:27:07 INFO - PROCESS | 24809 | 07:27:09 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52391/tests/kraken/driver.html?testName=audio-oscillator) 07:27:10 INFO - PROCESS | 24809 | RSS: Main: 180793344 07:27:10 INFO - PROCESS | 24809 | 07:27:12 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:27:13 INFO - PROCESS | 24809 | RSS: Main: 184971264 07:27:13 INFO - PROCESS | 24809 | 07:27:16 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52391/tests/kraken/driver.html?testName=imaging-darkroom) 07:27:16 INFO - PROCESS | 24809 | RSS: Main: 219815936 07:27:16 INFO - PROCESS | 24809 | 07:27:20 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52391/tests/kraken/driver.html?testName=imaging-desaturate) 07:27:20 INFO - PROCESS | 24809 | RSS: Main: 222257152 07:27:20 INFO - PROCESS | 24809 | 07:27:23 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52391/tests/kraken/driver.html?testName=json-parse-financial) 07:27:23 INFO - PROCESS | 24809 | RSS: Main: 221741056 07:27:23 INFO - PROCESS | 24809 | 07:27:25 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:27:26 INFO - PROCESS | 24809 | RSS: Main: 209633280 07:27:26 INFO - PROCESS | 24809 | 07:27:27 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52391/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:27:28 INFO - PROCESS | 24809 | RSS: Main: 212819968 07:27:28 INFO - PROCESS | 24809 | 07:27:30 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:27:31 INFO - PROCESS | 24809 | RSS: Main: 213381120 07:27:31 INFO - PROCESS | 24809 | 07:27:33 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:27:34 INFO - PROCESS | 24809 | RSS: Main: 225714176 07:27:34 INFO - PROCESS | 24809 | 07:27:36 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:27:37 INFO - PROCESS | 24809 | RSS: Main: 226652160 07:27:37 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | Cycle 1(1): loaded http://localhost:52391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52391/tests/kraken/driver.html?testName=ai-astar) 07:27:39 INFO - PROCESS | 24809 | RSS: Main: 269021184 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | __start_tp_report 07:27:39 INFO - PROCESS | 24809 | _x_x_mozilla_page_load 07:27:39 INFO - PROCESS | 24809 | _x_x_mozilla_page_load_details 07:27:39 INFO - PROCESS | 24809 | |i|pagename|runs| 07:27:39 INFO - PROCESS | 24809 | |0;ai-astar;102;112;111;110;113;111;110;112;110;110 07:27:39 INFO - PROCESS | 24809 | |1;audio-beat-detection;144;116;122;182;122;121;151;116;160;117 07:27:39 INFO - PROCESS | 24809 | |2;audio-dft;161;161;159;161;161;159;160;161;162;161 07:27:39 INFO - PROCESS | 24809 | |3;audio-fft;74;75;75;125;75;75;73;78;108;74 07:27:39 INFO - PROCESS | 24809 | |4;audio-oscillator;83;83;110;83;83;83;119;83;84;133 07:27:39 INFO - PROCESS | 24809 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;117;117;116 07:27:39 INFO - PROCESS | 24809 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;145;146 07:27:39 INFO - PROCESS | 24809 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;94 07:27:39 INFO - PROCESS | 24809 | |8;json-parse-financial;53;51;51;51;51;53;52;52;51;52 07:27:39 INFO - PROCESS | 24809 | |9;json-stringify-tinderbox;61;62;62;62;63;61;63;61;61;62 07:27:39 INFO - PROCESS | 24809 | |10;stanford-crypto-aes;80;76;74;74;83;77;78;74;74;78 07:27:39 INFO - PROCESS | 24809 | |11;stanford-crypto-ccm;119;119;117;119;125;118;118;118;196;137 07:27:39 INFO - PROCESS | 24809 | |12;stanford-crypto-pbkdf2;155;155;158;153;155;156;157;159;157;158 07:27:39 INFO - PROCESS | 24809 | |13;stanford-crypto-sha256-iterative;62;65;65;65;63;66;63;62;61;64 07:27:39 INFO - PROCESS | 24809 | __end_tp_report 07:27:39 INFO - PROCESS | 24809 | __start_cc_report 07:27:39 INFO - PROCESS | 24809 | _x_x_mozilla_cycle_collect,1635 07:27:39 INFO - PROCESS | 24809 | __end_cc_report 07:27:39 INFO - PROCESS | 24809 | __startTimestamp1468506459346__endTimestamp 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | ------- Summary: start ------- 07:27:39 INFO - PROCESS | 24809 | Number of tests: 14 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.03 (2.7%) stddev-sans-first:1.12 07:27:39 INFO - PROCESS | 24809 | Values: 102.0 112.0 111.0 110.0 113.0 111.0 110.0 112.0 110.0 110.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:133.00 stddev:22.98 (17.3%) stddev-sans-first:24.14 07:27:39 INFO - PROCESS | 24809 | Values: 144.0 116.0 122.0 182.0 122.0 121.0 151.0 116.0 160.0 117.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 07:27:39 INFO - PROCESS | 24809 | Values: 161.0 161.0 159.0 161.0 161.0 159.0 160.0 161.0 162.0 161.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:18.05 (24.1%) stddev-sans-first:18.83 07:27:39 INFO - PROCESS | 24809 | Values: 74.0 75.0 75.0 125.0 75.0 75.0 73.0 78.0 108.0 74.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:83.00 stddev:18.93 (22.8%) stddev-sans-first:19.63 07:27:39 INFO - PROCESS | 24809 | Values: 83.0 83.0 110.0 83.0 83.0 83.0 119.0 83.0 84.0 133.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:27:39 INFO - PROCESS | 24809 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 07:27:39 INFO - PROCESS | 24809 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:27:39 INFO - PROCESS | 24809 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.73 07:27:39 INFO - PROCESS | 24809 | Values: 53.0 51.0 51.0 51.0 51.0 53.0 52.0 52.0 51.0 52.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 07:27:39 INFO - PROCESS | 24809 | Values: 61.0 62.0 62.0 62.0 63.0 61.0 63.0 61.0 61.0 62.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.50 stddev:3.05 (3.9%) stddev-sans-first:3.00 07:27:39 INFO - PROCESS | 24809 | Values: 80.0 76.0 74.0 74.0 83.0 77.0 78.0 74.0 74.0 78.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:119.00 stddev:24.44 (20.5%) stddev-sans-first:25.67 07:27:39 INFO - PROCESS | 24809 | Values: 119.0 119.0 117.0 119.0 125.0 118.0 118.0 118.0 196.0 137.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:157.00 stddev:1.83 (1.2%) stddev-sans-first:1.88 07:27:39 INFO - PROCESS | 24809 | Values: 155.0 155.0 158.0 153.0 155.0 156.0 157.0 159.0 157.0 158.0 07:27:39 INFO - PROCESS | 24809 | 07:27:39 INFO - PROCESS | 24809 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.50 stddev:1.65 (2.6%) stddev-sans-first:1.64 07:27:39 INFO - PROCESS | 24809 | Values: 62.0 65.0 65.0 65.0 63.0 66.0 63.0 62.0 61.0 64.0 07:27:39 INFO - PROCESS | 24809 | -------- Summary: end -------- 07:27:39 INFO - PROCESS | 24809 | 07:27:40 INFO - TEST-INFO | 24809: exit 0 07:27:40 INFO - TEST-OK | kraken | took 60156ms 07:27:40 INFO - SUITE-END | took 1173s 07:27:40 INFO - Completed test suite (00:19:33) 07:27:40 INFO - javascript benchmark 07:27:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3034.908952731418, 3046.405950839587, 3083.7224649781515, 3086.9845650771745, 3101.5502752100947, 5256.632035757499, 5291.973540132299, 5297.417284098756, 5398.379186393561, 5427.511523962838, 5278.3665960084845, 5281.075811732951, 5353.116735738598, 5419.512243898049, 5421.0, 4726.858194254178, 4809.927851082237, 4822.6624136310475, 4847.2971419144205, 4966.0, 4891.021795640868, 4933.531314525132, 4940.629452791055, 4945.035718034985, 4961.677490963094, 4742.834000809972, 4763.26169443735, 4797.280407938802, 4849.810702548257, 4862.294967229732, 4771.141194584973, 4780.617550595944, 4791.0, 4853.174960256765, 4929.950700492985, 4767.7616119194245, 4816.422029356465, 4817.060673168733, 4825.396825396825, 4842.612590992712, 5161.587073034186, 5267.130923397634, 5355.25026496287, 5373.355197376301, 5391.32608423947, 5749.195112684228, 5788.797392091299, 5801.796937107223, 5802.65184088956, 5803.883922321572, 5788.507976821975, 5809.419058094199, 5849.298084229919, 5850.5612079094235, 5851.356350801409, 5198.090334191501, 5244.8688782780355, 5330.093884039761, 5354.839354819362, 5420.13277875538, 5914.142449344821, 5914.319853216849, 5925.318588362394, 5925.4370834770625, 5932.733027013708, 5629.549636029108, 5634.887302253932, 5670.971645141748, 5671.801486947937, 5682.346530149003, 5547.7780888764, 5615.129654903497, 5673.0, 5682.7442765075675, 5731.853629274078, 5652.0674088774895, 5652.830415087554, 5657.462541058593, 5661.886762264731, 5665.688387138664, 5515.448455154533, 5665.603407761417, 5678.630888992202, 5683.0, 5707.600467967202, 4284.871453856389, 4296.699231053796, 4313.482382114166, 4346.760928148982, 4405.603495685404, 3888.241792850367, 3889.0666240102173, 3892.6885849132, 3924.117073658404, 3925.7644541327613, 5361.758720857571, 5399.271098401666, 5401.864953376118, 5404.189371594213, 5416.91874621881, 5455.5908306877145, 5645.5201307888465, 5650.773969041193, 5672.234248376499, 5734.971325143431, 5412.91880621791, 5422.267993820784, 5423.728813559306, 5424.403315635277, 5424.674519528841, 4659.697119687209, 4785.808567657325, 4788.688735232199, 4799.592034677022, 4835.0571638530855, 5804.767809287666, 5848.707564621837, 5865.941340586625, 5888.146218798251, 5911.556633252523, 5703.058995265735, 5717.971410142923, 5726.284214473191, 5729.398413166724, 5741.971290143522, 5739.282589676291, 5754.079347304411, 5881.235439392852, 5898.351181370132, 5900.970495147497, 5599.468050535193, 5617.943820561742, 5627.943720562906, 5631.774729010794, 5683.630564013326, 5697.287839020122, 5707.714614269353, 5707.914381284201, 5711.685857277889, 5713.571482138939, 5317.680939143664, 5516.613837031369, 5555.111182210827, 5571.582131340085, 5575.609707320448, 5631.352394474524, 5637.46444087811, 5640.830775076754, 5644.463775941279, 5676.68778217202, 5539.307586551681, 5548.361938377138, 5571.4428557143965, 5574.777008919597, 5583.35791383996, 5455.618106732491, 5536.252605898152, 5600.383957764724, 5604.971975140098, 5665.716714164358, 5377.623566350318, 5435.374931882884, 5442.183672449164, 5478.616496845182, 5485.259489968963], "value": 5252.081524501845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.5036693626948, 613.9386061393858, 620.987580248395, 630.1115427247582, 639.6354078175439, 30633.846830765844, 42958.785206074004, 43213.0, 43988.0, 44008.3398749019, 40902.7954860226, 45818.0, 45833.0, 45880.0, 45911.770441147746, 8095.311898488636, 8999.460032398061, 9157.130072643089, 9158.358914875962, 10753.731156721065, 10576.36541807494, 10656.627018054369, 10966.616168434106, 10967.177461690406, 10970.945145274263, 10978.0, 10983.890161098407, 11025.779484410306, 11035.944820275927, 11041.558337666484, 10921.344719316827, 11004.339739615649, 11018.724531886686, 11032.889671103307, 11036.282641628268, 10944.507497162567, 10992.560297588087, 11012.889871101266, 11017.173711971554, 11018.11855051594, 44450.55549444496, 44732.3290150648, 44754.32868506975, 44779.0, 44780.55219447829, 3535.5934067582302, 3547.2018795771005, 3614.313280476701, 3786.318462676717, 3941.310270702644, 33615.6638433615, 34111.31777364439, 34519.4822077669, 35482.29035419277, 35664.0, 4229.577042295746, 4232.746035237865, 4253.74477531346, 4259.893502662428, 4321.2005778931, 375485.0, 377480.0, 378092.0, 378248.1087594572, 379578.0, 64888.02667959985, 65563.0, 65665.34334656592, 65671.0, 65710.34289657042, 68485.65757171281, 68538.0, 68606.31393686098, 68679.31320686729, 68946.65526672435, 15149.091054536762, 15456.304466299043, 15472.226388680521, 15478.9226053869, 15488.225588720745, 12065.336406497552, 12229.266244025386, 12247.755044899051, 12252.387380631111, 12261.448234829453, 15027.849721502864, 18500.722489162672, 20492.487687807923, 20578.691319630216, 20626.174953002013, 6976.232614412411, 7219.747308844166, 7278.0, 7410.96294518524, 7542.094948606203, 939.7603611079131, 977.5405559387077, 1015.8019186258756, 1016.9949150254201, 1126.9913427482356, 32420.0, 32466.32652042379, 32725.67274327274, 32835.0, 33414.83292583522, 1118.8321751737305, 1121.1815374776295, 1142.7885841119419, 1156.5894107591853, 1181.2971282087144, 16850.32598696063, 17151.0, 17183.57041073983, 17235.75939115133, 17274.913625431793, 533307.0, 539339.0, 539778.0, 540414.0, 542381.0, 60255.69872150611, 60934.0, 61050.69474652598, 61059.0, 61101.38898611046, 1220.6582156996055, 1281.448976939906, 1292.2634098563728, 1319.3205499167937, 1344.395022239996, 32847.34305313833, 33671.15822104467, 33865.0, 33921.32157356889, 33998.74049120894, 51952.740236298574, 52743.73628131835, 52823.73588132035, 52877.0, 52899.47100528945, 421697.0, 426059.0, 429650.0, 433093.0, 433099.0, 24971.87514062418, 28035.719642804128, 28213.0, 28640.563132424242, 29175.854120729262, 48824.64520870402, 49013.50986490232, 49700.50299496959, 49901.0, 50222.74443138951, 41042.0, 42080.57919420889, 42669.78665106655, 43336.783316083216, 43545.56454435415, 42186.7890660557, 42267.57732422637, 42369.788151059045, 42791.57208428001, 43715.78142109269, 41749.79125104355, 41907.58092419037, 42968.78515607527, 43156.352654709575, 43229.13541729085, 35576.46635300421, 36105.27789444144, 36409.45385819162, 37096.258074838894, 37272.06819829526, 27894.581581276703, 27937.44125117527, 28129.0, 28197.295067623472, 28204.294892627848], "value": 20965.923747615987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.99415008774855, 392.432934409778, 395.1819733152376, 401.4219523885605, 413.23551429854774, 13355.866441335584, 18976.52558686032, 20338.898305508472, 20347.89826050868, 20418.795812041913, 15799.447019354326, 19169.712454313198, 19349.0, 19925.302614408498, 20025.799742002575, 5648.435156484339, 5807.709614519278, 5814.651120932736, 5814.941850581482, 5826.563007774434, 5760.913586296209, 5800.883982320351, 5810.970945145289, 5855.297364316288, 5907.793227237047, 5691.8292451226525, 5757.913631295513, 5797.681127537984, 5817.447342502455, 5819.650820950736, 5616.634918730269, 5706.058500347438, 5748.45389687979, 5778.653280803165, 5783.045797443417, 5070.974645126787, 5078.873028174288, 5082.440931497532, 5095.515925987025, 5102.795888164469, 23134.768652313596, 23801.0, 24177.03291868323, 25107.121250756318, 25172.24483265505, 2472.7403622619727, 2477.3930387055107, 2560.8335458195156, 2564.7948164146824, 2809.6909339972585, 14891.627709307246, 15058.774118388234, 15188.544343669708, 15296.464623738117, 15357.923210383988, 1958.3243780895568, 1977.416662084674, 2018.4247489465579, 2029.2593203480772, 2063.886486243256, 80692.0, 85301.57349213277, 85354.57322713347, 86317.56841215817, 86506.0, 10165.593376265015, 10521.473926303654, 10551.84172237417, 10649.787004259872, 10980.341179529254, 15034.548963531111, 15179.089254644756, 15247.466338678092, 15274.541763747106, 15277.388904443698, 7746.961265193638, 8062.677492900219, 8080.151584083704, 8139.877901831477, 8152.103268640445, 6766.83082922921, 7647.617619119133, 7716.151223365426, 7761.573113478813, 7818.8827167592535, 6259.467945224706, 6602.966985165043, 6745.494087943423, 6751.662416879137, 6867.381935625817, 1958.2069261948934, 1972.142118178597, 1978.1889425335544, 2014.5467269864164, 2043.4686981384948, 1043.2905624175633, 1096.572336788653, 1098.3080659184664, 1114.5318966034285, 1125.1280257800106, 19133.712994304817, 20080.39758807238, 20582.176712931316, 20648.17407303721, 20716.689249661267, 1022.5756311130946, 1028.8456731490187, 1029.2383636109225, 1063.962761303366, 1115.4255558387438, 11077.667669969753, 11664.416779161009, 11684.247362895634, 11722.765544689059, 11762.294262344287, 238592.0, 239438.0, 240197.0, 241366.0, 492845.0, 100457.0, 109440.0, 109617.0, 109637.45181274043, 109947.45026274817, 998.3460833154296, 1027.075631931253, 1037.5953378182514, 1040.193849766437, 1048.2138396202847, 17753.467395978143, 17806.46580602584, 18369.81630183681, 18477.353292634692, 18555.72166417532, 30459.2385190372, 37395.2520949574, 40423.7978810104, 45471.0, 46810.76594617005, 64782.0, 65100.34899650943, 65347.0, 66064.33935660582, 66200.66899665471, 8717.433366831136, 8727.694530691395, 8773.078826723358, 8856.0, 9105.226055785333, 10514.684559463229, 12618.747625047632, 13994.510192143227, 14049.578512644637, 14050.718985620026, 11578.36319002463, 12001.81997270059, 12223.0, 12260.816087758869, 12445.937770311453, 10564.418956957441, 11704.298794940314, 12078.154529182873, 12274.631761047183, 12364.319962402154, 12010.819837702267, 12046.277223366626, 12304.938475307566, 12375.814362784746, 12645.557405490763, 8279.130691277329, 8379.45533540318, 8471.66113355459, 8773.034966153846, 8887.955770172766, 10209.336393134423, 11736.002439792714, 12040.75918481608, 12382.0, 12492.06309526771], "value": 9471.501382039323, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.0538812055318, 1407.2963518240877, 1456.0171883978314, 1536.231884057971, 1750.2211515875433, 8710.695125670603, 9055.909440905589, 9082.273418126559, 9261.583228754705, 9262.397944133643, 9051.818963620724, 9239.0, 9255.722328330145, 9258.814823703522, 9276.953615231914, 2058.084152552115, 2313.3406979010983, 2333.0900948630006, 2358.5872472317274, 2379.274321331993, 2407.085307583116, 2415.118481754165, 2415.770501802326, 2416.2871952773885, 2418.613021916494, 2294.804941579959, 2302.815774738017, 2302.827287953402, 2303.1133013789645, 2365.184011516033, 2005.0977060322841, 2196.9560608787892, 2244.51742875281, 2253.019936327703, 2320.93037208884, 2318.9072437102495, 2354.023080421623, 2359.622460406344, 2374.299581623425, 2379.7977171940406, 9258.074192580756, 9311.674091406836, 9318.767030824216, 9323.860142097874, 9344.252459803267, 5063.215201643751, 5184.170532714747, 5230.032443997872, 5243.187305967581, 5250.894982100336, 3132.420502207076, 3216.758743094254, 3281.7210537104374, 3299.7195238404765, 3313.7017668409717, 1141.303804679145, 1169.4152923538231, 1170.1453196683267, 1177.0, 1184.1059999700171, 11894.82157767634, 11896.702582435508, 11903.345316007617, 11908.761824763456, 11921.165518413714, 4413.3159360299205, 4469.910601787946, 4632.791524381411, 4633.374494443275, 4638.165130276515, 10116.494175291205, 10141.797164056678, 10143.391396516232, 10144.391336519833, 10155.289129760993, 5232.529072383504, 5232.555232805178, 5234.084035293885, 5234.450382709837, 5238.292830467914, 4478.820847166142, 4901.142300097468, 5063.544281014726, 5069.493050694901, 5125.179971204664, 4073.368627862686, 4083.244599749056, 4161.958380416218, 4176.331786914079, 4192.706510544293, 1162.2561560601223, 1223.3944197622234, 1247.4511215065343, 1290.11627035481, 1308.9018323625767, 1003.7039073473343, 1008.996048931318, 1011.4588695048114, 1017.4149863828328, 1028.0644613401769, 6323.0, 6324.6521441321165, 6397.200349956255, 6421.101045853584, 6522.771702990372, 961.5528779117604, 970.7573106723319, 972.4359871274644, 998.2313618513849, 1004.1213937804421, 4054.432379466877, 4121.0, 4134.462519872397, 4136.0, 4160.812763425653, 10478.161747060218, 10805.513751881184, 10888.0, 10896.128309735202, 10912.072473839813, 10777.62278320255, 10815.297005694605, 10816.296940698829, 10824.296420732628, 10839.729006774895, 8104.554249516334, 8390.202930721573, 8445.535495547803, 8595.742127736054, 8700.216980471789, 6188.504919606511, 6490.7079181436, 6515.153030106056, 6540.345965403421, 6542.54202205841, 10667.466626668791, 10758.246922715334, 10905.400202988912, 10977.176711746491, 11038.337699738042, 10651.786964260826, 10997.175211859303, 11041.33751974884, 11171.608993685182, 11189.552417903193, 8211.38414618894, 8301.584920753818, 8404.36967227448, 8411.621477033426, 8420.452670576638, 8898.377113602244, 8930.553472326228, 8988.640454381752, 8988.820223595621, 9003.14470125337, 6421.775237866652, 7604.581748003913, 7758.3017528422715, 7873.37013038944, 8380.07819139882, 7989.9201007991505, 8069.515829050276, 8076.71731489395, 8249.340052795882, 8274.089850116603, 7382.2617738225745, 7394.815129621587, 7475.327220550176, 7502.287282708134, 7510.774676759706, 5313.760880760297, 5340.172273297645, 5340.893182136413, 5389.83830485086, 5417.702026388429, 5282.102042652835, 5320.414754377093, 5428.755705993319, 5446.727663616883, 5481.260029895913], "value": 4746.023255974221, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.5646518363168, 332.7422343541414, 339.2130257801899, 340.7001838382224, 342.8217326989967, 5203.609729270305, 5262.421133675298, 5332.866678333039, 5387.622866399343, 5389.356246344863, 5320.654157479761, 5322.946770532293, 5325.387580428252, 5330.653507522008, 5363.892722145555, 4128.463299771026, 4167.229062623424, 4178.582141785828, 4190.53904070552, 4194.8254488743205, 3878.0, 3980.8208630611693, 4111.876643700693, 4116.197341518405, 4148.730332528391, 4097.549269580359, 4108.650764685005, 4112.8971775705695, 4125.381192821086, 4128.236276288896, 3957.8614748483665, 4130.359794231899, 4131.607497287753, 4140.81366338514, 4147.564505726886, 3533.9293214135832, 3560.2523470071055, 3562.109472631842, 3571.3750093733493, 3591.3894637911358, 5113.693178409308, 5144.151215049513, 5157.355330583677, 5194.844154675366, 5226.712530810804, 4664.393628828265, 4667.579917807379, 4667.953320466786, 4672.929906051412, 4678.836240731558, 5257.421683614799, 5518.758279387146, 5519.751611177507, 5528.695921724304, 5564.610477266593, 4025.4766880305665, 4043.3126368517424, 4055.4119652650497, 4062.0908173158864, 4074.164796216798, 5344.599155063386, 5438.0, 5718.628289161233, 5759.308882934075, 5771.682557459338, 4168.8332466700995, 4171.270027745193, 4173.83304667816, 4176.352665336878, 4177.582241775798, 4198.8110535026, 4206.221848957953, 4224.598663126998, 4237.427947227085, 4250.978745106317, 4778.474367819537, 4787.521247875255, 4787.946651736613, 4790.664653474223, 4790.664653474293, 5376.91934620981, 5624.493795558419, 5660.066089095253, 5661.179129026268, 5664.54683625309, 1463.3780643226587, 1465.934032968519, 1467.2663668165917, 1468.142799358812, 1469.3828591991175, 917.9495127767904, 933.1399261264204, 945.3004776465503, 949.7435692363161, 950.6435086842434, 4802.495737947535, 4804.231322988305, 4809.831655892097, 4816.638752093607, 4878.219449900761, 5076.6446348755235, 5088.389393272831, 5090.898182036339, 5091.312672789126, 5093.6247213252955, 4660.300954856799, 4830.7101573905675, 4834.806607735652, 4839.854804355875, 4847.206533582597, 2703.932401689934, 2723.5233834079354, 2724.209979106077, 2728.4133911208787, 2739.5890616407696, 5137.818301790609, 5231.55531779803, 5239.29269548606, 5244.685318880803, 5280.81517146898, 5000.9496106596125, 5140.280360749498, 5199.414178675464, 5266.894662106736, 5637.746301416446, 5747.683877386784, 5881.882362352729, 5894.848380341059, 5900.675462849585, 5909.379515150933, 5691.174779657009, 5701.372848986691, 5716.771329146787, 5717.313922329347, 5747.770089196385, 5381.892362152813, 5601.6639001658405, 5614.382417934105, 5631.746571404215, 5650.773969041193, 5850.707464626837, 5853.619514731699, 5874.325817142094, 5881.32364778056, 5884.382139875252, 4195.769232692109, 4203.726757760735, 4219.683523735794, 4221.915561688687, 4224.746515209097, 5489.698066606375, 5708.771649133988, 5715.799947001835, 5734.598578099493, 5744.971275143765, 5530.253415788817, 5573.693446860461, 5574.554035677055, 5582.385937546947, 5583.581231407579, 5304.283921670525, 5509.972450137724, 5535.391106978149, 5558.388577256579, 5586.441355864381, 5466.34403871538, 5481.095619222783, 5502.862428439321, 5506.513241424873, 5515.917261241005, 5524.309461317335, 5579.442055794388, 5589.832305030693, 5627.8593035174445, 5641.702408446163, 5317.57459403239, 5437.456254374689, 5440.646357986719, 5465.562754979513, 5465.9726701366235], "value": 4176.931238435454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.3460490463216, 752.7892190186747, 763.1147868472573, 767.8541077195332, 813.6501304439096, 15570.53288401347, 16267.349306027745, 16929.492115236564, 16939.237734301954, 16997.49007529773, 15764.0, 15870.444534441296, 15924.601884952883, 15972.84027159728, 16047.0, 681.4105798484325, 796.7052190689453, 800.7837883771364, 826.2811354121923, 827.2513375395276, 820.3683163963774, 830.3979614779297, 830.6179157587517, 831.6132998155856, 832.0182185021672, 870.8737233101197, 874.8906386701663, 875.8948926128874, 876.0319846569545, 876.3252295732283, 707.2609123465965, 838.279079991207, 861.6854847980474, 862.409249663979, 863.2230992107154, 626.890294198518, 626.971786269619, 627.0437582686394, 627.4415769964735, 627.8838414893214, 14138.646533836736, 14244.572662820132, 14258.928705356408, 14264.144151350953, 14283.928580357031, 13946.93026534871, 14285.57143285703, 14393.640158996004, 14508.854911450855, 14764.704705905822, 13109.147905386119, 13325.600231993056, 13524.391402386917, 13585.184888906697, 13849.653758656013, 4546.749928753918, 4602.631789456836, 4615.8153673853, 4616.699914505546, 4695.859124226278, 79186.60406697987, 79738.20261797424, 80310.0, 80728.59635701784, 80938.59530702309, 11137.331760094421, 11401.714957125972, 11422.942885285687, 11486.425678716198, 11609.245399049034, 20619.381418557467, 20928.581428371654, 20936.267230646856, 20986.0, 21266.468338291357, 8530.360222983301, 8666.56667166639, 8676.913230867736, 8696.91303086961, 8773.561321933877, 4829.323894654751, 4915.508449155127, 4949.406071271471, 4983.626228032912, 5194.948050519522, 3385.881494147693, 3452.2922800825772, 3476.60019097807, 3492.2840817632323, 3494.4583589543663, 589.6579983609582, 602.9577929544889, 608.1091201389896, 616.8057062025448, 618.1469571990624, 515.5051150895108, 678.609799365357, 704.3519961635308, 783.8314762326128, 796.1640277708383, 9642.42145471274, 10172.898271017342, 10404.427756473468, 10425.270231083903, 10483.266171367932, 669.9397054265042, 670.33971538035, 725.2095216214352, 737.9298966598164, 778.6457161991281, 4835.734034628059, 4840.515948405131, 4857.8299759508245, 4908.901821963541, 4945.851624451272, 109874.0, 114551.0, 116982.0, 119624.0, 121907.0, 101894.0, 104503.06766812348, 105271.4736426313, 105806.0, 107443.46278268714, 58657.41342586605, 77415.2258477408, 79368.20631793608, 83926.58036709778, 92639.0, 10130.949345253226, 10293.691479049958, 10321.225908056776, 10888.837133243971, 11012.339259644446, 37710.0, 42917.0, 53167.20249196343, 53213.7339313301, 54450.0, 73777.0, 75359.0, 75868.24131758611, 77813.0, 80146.0, 13220.074594778273, 13271.800922985969, 13323.533676321282, 13341.132826366254, 13509.324533773468, 15248.652932643981, 15557.0, 15580.0, 15653.530394088195, 16214.918925405298, 14054.508092216724, 14177.14937103777, 14290.28548572588, 14594.343254553358, 14711.632209194855, 14545.92727036358, 14779.556613301618, 14784.260786960394, 15209.695806083595, 15247.16140612277, 14320.427182912566, 14421.7836732447, 14462.566123016326, 14526.782098268322, 15071.321790519673, 11404.7495716619, 11417.31496110236, 11431.977942820173, 11848.686591284151, 11889.762204756029, 11851.585194518151, 11910.583129590423, 11915.2255103418, 12073.57742479009, 12144.817827732415], "value": 7766.162352250519, "unit": "score"}], "name": "dromaeo_css", "value": 7372.546567576232, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 110.0, 113.0, 111.0, 110.0, 112.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 122.0, 182.0, 122.0, 121.0, 151.0, 116.0, 160.0, 117.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 161.0, 161.0, 159.0, 160.0, 161.0, 162.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 125.0, 75.0, 75.0, 73.0, 78.0, 108.0, 74.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 110.0, 83.0, 83.0, 83.0, 119.0, 83.0, 84.0, 133.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 51.0, 53.0, 52.0, 52.0, 51.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 63.0, 61.0, 63.0, 61.0, 61.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 74.0, 74.0, 83.0, 77.0, 78.0, 74.0, 74.0, 78.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 119.0, 125.0, 118.0, 118.0, 118.0, 196.0, 137.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 158.0, 153.0, 155.0, 156.0, 157.0, 159.0, 157.0, 158.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 65.0, 65.0, 63.0, 66.0, 63.0, 62.0, 61.0, 64.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1479.3999999999996, "alertThreshold": 2.0}]} 07:27:40 INFO - Return code: 0 07:27:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:27:40 INFO - # TBPL SUCCESS # 07:27:40 INFO - Running post-action listener: _resource_record_post_action 07:27:40 INFO - ##### 07:27:40 INFO - ##### Finished run-tests step (success) 07:27:40 INFO - ##### 07:27:40 INFO - Running post-run listener: _resource_record_post_run 07:27:40 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556564480; Read time: 12; Write time: 449876 07:27:40 INFO - TinderboxPrint: CPU usage
13.0% 07:27:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:27:40 INFO - TinderboxPrint: I/O write bytes / time
556,564,480 / 449,876 07:27:40 INFO - TinderboxPrint: CPU idle
8,264.7 (86.9%) 07:27:40 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 07:27:40 INFO - TinderboxPrint: Swap in / out
0 / 0 07:27:40 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 263933952; Read time: 0; Write time: 259332 07:27:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292630528; Read time: 12; Write time: 190544 07:27:41 INFO - Running post-run listener: _upload_blobber_files 07:27:41 INFO - Blob upload gear active. 07:27:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:27:41 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 07:27:41 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'] 07:27:41 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 07:27:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:27:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:27:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:27:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:42 INFO - (blobuploader) - INFO - Done attempting. 07:27:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:27:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:27:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:46 INFO - (blobuploader) - INFO - Done attempting. 07:27:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:27:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:27:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:46 INFO - (blobuploader) - INFO - Done attempting. 07:27:46 INFO - (blobuploader) - INFO - Iteration through files over. 07:27:46 INFO - Return code: 0 07:27:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:27:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:27:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b32901ce5c661adafa8125834523ade0957bdd8ef9a8eaf9215e9b3f7316a2d10b1900f2fabed4caa2cb0e334abbaa1dc6329de43d2badbe95530e32c355dbfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e9c032d44b900fe4bcdb24ef34b5afb171bcf465be43c8b6a072a27ad54ed46500331d3d76d3999288e2e0f587d527190c24c203d609e8fdb30a93d159a807e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ea4a200dc8238fe41bd6933006fb00ee45e8fe6bb015d0c64a5e591f027dbfa7158a0fd1a03566e8d089a6a9ca1ada6d82d444988172050bd2e15d229fe0133"} 07:27:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:27:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:27:46 INFO - Contents: 07:27:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b32901ce5c661adafa8125834523ade0957bdd8ef9a8eaf9215e9b3f7316a2d10b1900f2fabed4caa2cb0e334abbaa1dc6329de43d2badbe95530e32c355dbfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e9c032d44b900fe4bcdb24ef34b5afb171bcf465be43c8b6a072a27ad54ed46500331d3d76d3999288e2e0f587d527190c24c203d609e8fdb30a93d159a807e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ea4a200dc8238fe41bd6933006fb00ee45e8fe6bb015d0c64a5e591f027dbfa7158a0fd1a03566e8d089a6a9ca1ada6d82d444988172050bd2e15d229fe0133"} 07:27:46 INFO - Running post-run listener: copy_logs_to_upload_dir 07:27:46 INFO - Copying logs to upload dir... 07:27:46 INFO - mkdir: /builds/slave/test/build/upload/logs 07:27:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.874704 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-14 07:27:46.517967) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:27:46.522219) ========= 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=ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746 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/b32901ce5c661adafa8125834523ade0957bdd8ef9a8eaf9215e9b3f7316a2d10b1900f2fabed4caa2cb0e334abbaa1dc6329de43d2badbe95530e32c355dbfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e9c032d44b900fe4bcdb24ef34b5afb171bcf465be43c8b6a072a27ad54ed46500331d3d76d3999288e2e0f587d527190c24c203d609e8fdb30a93d159a807e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ea4a200dc8238fe41bd6933006fb00ee45e8fe6bb015d0c64a5e591f027dbfa7158a0fd1a03566e8d089a6a9ca1ada6d82d444988172050bd2e15d229fe0133"} build_url:https://queue.taskcluster.net/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/ZdTNryMzQFiVXwoZFw7Xyg/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/b32901ce5c661adafa8125834523ade0957bdd8ef9a8eaf9215e9b3f7316a2d10b1900f2fabed4caa2cb0e334abbaa1dc6329de43d2badbe95530e32c355dbfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e9c032d44b900fe4bcdb24ef34b5afb171bcf465be43c8b6a072a27ad54ed46500331d3d76d3999288e2e0f587d527190c24c203d609e8fdb30a93d159a807e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ea4a200dc8238fe41bd6933006fb00ee45e8fe6bb015d0c64a5e591f027dbfa7158a0fd1a03566e8d089a6a9ca1ada6d82d444988172050bd2e15d229fe0133"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:27:46.549818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:27:46.550307) ========= 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=ed14279e38b05397cf4aa391000001a4-1468505236.131305-2063607746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:27:46.632359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:27:46.632917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:27:46.633361) ========= ========= Total master_lag: 0.17 =========