builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1467369815.39 results: success (0) buildid: 20160701021823 builduid: bd08576ca08b4d53902e853fbebc2079 revision: fdcee57b4e4f66a82831ab01e61500da98a858e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:35.393533) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:35.394136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:35.394464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:35.410368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:35.410672) ========= 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=745a4373a2a16df560f216e000000264-1467369815.289176-1036070337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 03:43:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 226M=0s 2016-07-01 03:43:36 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075312 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:35.501131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:35.501524) ========= 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=745a4373a2a16df560f216e000000264-1467369815.289176-1036070337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015048 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:35.551312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 03:43:35.551708) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fdcee57b4e4f66a82831ab01e61500da98a858e8 --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 fdcee57b4e4f66a82831ab01e61500da98a858e8 --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=745a4373a2a16df560f216e000000264-1467369815.289176-1036070337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 03:43:36,387 truncating revision to first 12 chars 2016-07-01 03:43:36,387 Setting DEBUG logging. 2016-07-01 03:43:36,387 attempt 1/10 2016-07-01 03:43:36,387 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fdcee57b4e4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 03:43:37,632 unpacking tar archive at: mozilla-central-fdcee57b4e4f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.588850 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 03:43:37.155208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:37.155629) ========= script_repo_revision: fdcee57b4e4f66a82831ab01e61500da98a858e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:37.156115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:37.156436) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 03:43:37.168382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-01 03:43:37.168753) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=745a4373a2a16df560f216e000000264-1467369815.289176-1036070337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:43:38 INFO - MultiFileLogger online at 20160701 03:43:38 in /builds/slave/test 03:43:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:43:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:38 INFO - {'append_to_log': False, 03:43:38 INFO - 'base_work_dir': '/builds/slave/test', 03:43:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:43:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:38 INFO - 'branch': 'Firefox-Non-PGO', 03:43:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:38 INFO - 'config_files': ('talos/linux_config.py',), 03:43:38 INFO - 'default_actions': ('clobber', 03:43:38 INFO - 'read-buildbot-config', 03:43:38 INFO - 'download-and-extract', 03:43:38 INFO - 'populate-webroot', 03:43:38 INFO - 'create-virtualenv', 03:43:38 INFO - 'install', 03:43:38 INFO - 'run-tests'), 03:43:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:38 INFO - 'download_minidump_stackwalk': True, 03:43:38 INFO - 'download_symbols': 'ondemand', 03:43:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:43:38 INFO - 'tooltool.py': '/tools/tooltool.py', 03:43:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:43:38 INFO - '/tools/misc-python/virtualenv.py')}, 03:43:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:38 INFO - 'installer_path': 'installer.exe', 03:43:38 INFO - 'log_level': 'info', 03:43:38 INFO - 'log_name': 'talos', 03:43:38 INFO - 'log_to_console': True, 03:43:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:43:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:43:38 INFO - 'opt_config_files': (), 03:43:38 INFO - 'pip_index': False, 03:43:38 INFO - 'sps_profile': False, 03:43:38 INFO - 'sps_profile_interval': 0, 03:43:38 INFO - 'suite': 'dromaeojs', 03:43:38 INFO - 'system_bits': '32', 03:43:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:38 INFO - 'title': 'talos-linux64-ix-032', 03:43:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:38 INFO - 'use_talos_json': True, 03:43:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:38 INFO - 'work_dir': 'build'} 03:43:38 INFO - ##### 03:43:38 INFO - ##### Running clobber step. 03:43:38 INFO - ##### 03:43:38 INFO - Running pre-action listener: _resource_record_pre_action 03:43:38 INFO - Running main action method: clobber 03:43:38 INFO - rmtree: /builds/slave/test/build 03:43:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:39 INFO - Running post-action listener: _resource_record_post_action 03:43:39 INFO - ##### 03:43:39 INFO - ##### Finished clobber step (success) 03:43:39 INFO - ##### 03:43:39 INFO - ##### 03:43:39 INFO - ##### Running read-buildbot-config step. 03:43:39 INFO - ##### 03:43:39 INFO - Running pre-action listener: _resource_record_pre_action 03:43:39 INFO - Running main action method: read_buildbot_config 03:43:39 INFO - Using buildbot properties: 03:43:39 INFO - { 03:43:39 INFO - "project": "", 03:43:39 INFO - "product": "firefox", 03:43:39 INFO - "script_repo_revision": "production", 03:43:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:43:39 INFO - "repository": "", 03:43:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:43:39 INFO - "buildid": "20160701021823", 03:43:39 INFO - "pgo_build": "False", 03:43:39 INFO - "basedir": "/builds/slave/test", 03:43:39 INFO - "buildnumber": 630, 03:43:39 INFO - "slavename": "talos-linux64-ix-032", 03:43:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:43:39 INFO - "platform": "ubuntu64_hw", 03:43:39 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:43:39 INFO - "branch": "mozilla-central", 03:43:39 INFO - "repo_path": "mozilla-central", 03:43:39 INFO - "revision": "fdcee57b4e4f66a82831ab01e61500da98a858e8", 03:43:39 INFO - "stage_platform": "linux64", 03:43:39 INFO - "builduid": "bd08576ca08b4d53902e853fbebc2079", 03:43:39 INFO - "slavebuilddir": "test" 03:43:39 INFO - } 03:43:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:43:39 INFO - Running post-action listener: _resource_record_post_action 03:43:39 INFO - ##### 03:43:39 INFO - ##### Finished read-buildbot-config step (success) 03:43:39 INFO - ##### 03:43:39 INFO - ##### 03:43:39 INFO - ##### Running download-and-extract step. 03:43:39 INFO - ##### 03:43:39 INFO - Running pre-action listener: _resource_record_pre_action 03:43:39 INFO - Running main action method: download_and_extract 03:43:39 INFO - mkdir: /builds/slave/test/build/tests 03:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:39 INFO - https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:43:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:43:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:43:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/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 03:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/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 03:43:39 INFO - Downloaded 1361 bytes. 03:43:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:43:39 INFO - Using the following test package requirements: 03:43:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:43:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:43:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:43:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:43:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:43:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:43:39 INFO - u'jsshell-linux-x86_64.zip'], 03:43:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:43:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:43:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:43:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:43:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:43:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:43:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:43:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:43:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:43:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:43:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:43:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:39 INFO - https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:43:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:43:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:43:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/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 03:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/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 03:43:40 INFO - Downloaded 22704200 bytes. 03:43:40 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'] 03:43:40 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 03:43:42 INFO - Return code: 0 03:43:42 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 03:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:42 INFO - https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:43:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:43:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:43:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/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 03:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/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 03:43:43 INFO - Downloaded 22704200 bytes. 03:43:43 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'] 03:43:43 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 03:43:44 INFO - Return code: 0 03:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:44 INFO - https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:43:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:43:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:43:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/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 03:43:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/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 03:43:45 INFO - Downloaded 14405242 bytes. 03:43:45 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'] 03:43:45 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 03:43:46 INFO - Return code: 0 03:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:46 INFO - https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:43:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:43:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:43:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/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 03:43:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ckkfhnz4T923IhmH-UxOqA/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 03:43:47 INFO - Downloaded 56445670 bytes. 03:43:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:43:47 INFO - mkdir: /builds/slave/test/properties 03:43:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:43:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:43:47 INFO - Contents: 03:43:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:43:48 INFO - Running post-action listener: _resource_record_post_action 03:43:48 INFO - Running post-action listener: set_extra_try_arguments 03:43:48 INFO - ##### 03:43:48 INFO - ##### Finished download-and-extract step (success) 03:43:48 INFO - ##### 03:43:48 INFO - ##### 03:43:48 INFO - ##### Running populate-webroot step. 03:43:48 INFO - ##### 03:43:48 INFO - Running pre-action listener: _resource_record_pre_action 03:43:48 INFO - Running main action method: populate_webroot 03:43:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:43:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:43:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:43:48 INFO - '--tppagecycles', 03:43:48 INFO - '7'], 03:43:48 INFO - 'tests': ['tsvgm']}}, 03:43:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:43:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:43:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:43:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:43:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:48 INFO - 'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:48 INFO - 'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['damp', 'tps']}, 03:43:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:48 INFO - 'tests': ['damp', 'tps']}, 03:43:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['dromaeo_dom']}, 03:43:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:43:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['basic_compositor_video']}, 03:43:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:43:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['a11yr', 03:43:48 INFO - 'ts_paint', 03:43:48 INFO - 'tpaint', 03:43:48 INFO - 'sessionrestore', 03:43:48 INFO - 'sessionrestore_no_auto_restore', 03:43:48 INFO - 'tabpaint']}, 03:43:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:43:48 INFO - 'ts_paint', 03:43:48 INFO - 'tpaint', 03:43:48 INFO - 'sessionrestore', 03:43:48 INFO - 'sessionrestore_no_auto_restore', 03:43:48 INFO - 'tabpaint']}, 03:43:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:43:48 INFO - 'ts_paint', 03:43:48 INFO - 'tpaint', 03:43:48 INFO - 'sessionrestore', 03:43:48 INFO - 'sessionrestore_no_auto_restore', 03:43:48 INFO - 'tabpaint']}, 03:43:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:43:48 INFO - 'ts_paint', 03:43:48 INFO - 'tpaint', 03:43:48 INFO - 'sessionrestore', 03:43:48 INFO - 'sessionrestore_no_auto_restore', 03:43:48 INFO - 'tabpaint']}, 03:43:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['a11yr', 03:43:48 INFO - 'ts_paint', 03:43:48 INFO - 'tpaint', 03:43:48 INFO - 'sessionrestore', 03:43:48 INFO - 'sessionrestore_no_auto_restore', 03:43:48 INFO - 'tabpaint']}, 03:43:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['a11yr', 03:43:48 INFO - 'ts_paint', 03:43:48 INFO - 'tpaint', 03:43:48 INFO - 'sessionrestore', 03:43:48 INFO - 'sessionrestore_no_auto_restore', 03:43:48 INFO - 'tabpaint']}, 03:43:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['tsvgx', 03:43:48 INFO - 'tsvgr_opacity', 03:43:48 INFO - 'tart', 03:43:48 INFO - 'tscrollx', 03:43:48 INFO - 'cart']}, 03:43:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:43:48 INFO - 'tsvgr_opacity', 03:43:48 INFO - 'tart', 03:43:48 INFO - 'tscrollx', 03:43:48 INFO - 'cart']}, 03:43:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:48 INFO - 'talos_options': ['--disable-e10s'], 03:43:48 INFO - 'tests': ['tp5o']}, 03:43:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:48 INFO - 'tests': ['tp5o']}, 03:43:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:48 INFO - 'talos_options': ['--disable-e10s', 03:43:48 INFO - '--xperf_path', 03:43:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:48 INFO - 'tests': ['tp5n']}, 03:43:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:48 INFO - 'talos_options': ['--xperf_path', 03:43:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:48 INFO - 'tests': ['tp5n']}}, 03:43:48 INFO - 'talos.zip': {'path': '', 03:43:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:43:48 INFO - Running post-action listener: _resource_record_post_action 03:43:48 INFO - ##### 03:43:48 INFO - ##### Finished populate-webroot step (success) 03:43:48 INFO - ##### 03:43:48 INFO - ##### 03:43:48 INFO - ##### Running create-virtualenv step. 03:43:48 INFO - ##### 03:43:48 INFO - Running pre-action listener: _resource_record_pre_action 03:43:48 INFO - Running main action method: create_virtualenv 03:43:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:43:48 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 03:43:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:43:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:43:48 INFO - Using real prefix '/usr' 03:43:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:43:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:43:50 INFO - Installing pip.................done. 03:43:50 INFO - Return code: 0 03:43:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:50 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 0x1506030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c53b0>, '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 0x17c62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c6740>, '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': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', '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 03:43:50 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 03:43:50 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 03:43:50 INFO - Using env: {'DISPLAY': ':0', 03:43:50 INFO - 'HOME': '/home/cltbld', 03:43:50 INFO - 'LANG': 'en_US.UTF-8', 03:43:50 INFO - 'LANGUAGE': 'en_US:en', 03:43:50 INFO - 'LOGNAME': 'cltbld', 03:43:50 INFO - 'MAIL': '/var/mail/cltbld', 03:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:50 INFO - 'MOZ_NO_REMOTE': '1', 03:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:50 INFO - 'NO_EM_RESTART': '1', 03:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:50 INFO - 'PWD': '/builds/slave/test', 03:43:50 INFO - 'SHELL': '/bin/bash', 03:43:50 INFO - 'SHLVL': '1', 03:43:50 INFO - 'TERM': 'linux', 03:43:50 INFO - 'TMOUT': '86400', 03:43:50 INFO - 'USER': 'cltbld', 03:43:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', 03:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:50 INFO - '_': '/tools/buildbot/bin/python'} 03:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:51 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 03:43:51 INFO - Cleaning up... 03:43:51 INFO - Return code: 0 03:43:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1506030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c53b0>, '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 0x17c62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c6740>, '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': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', '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 03:43:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:43:51 INFO - Using env: {'DISPLAY': ':0', 03:43:51 INFO - 'HOME': '/home/cltbld', 03:43:51 INFO - 'LANG': 'en_US.UTF-8', 03:43:51 INFO - 'LANGUAGE': 'en_US:en', 03:43:51 INFO - 'LOGNAME': 'cltbld', 03:43:51 INFO - 'MAIL': '/var/mail/cltbld', 03:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:51 INFO - 'MOZ_NO_REMOTE': '1', 03:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:51 INFO - 'NO_EM_RESTART': '1', 03:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:51 INFO - 'PWD': '/builds/slave/test', 03:43:51 INFO - 'SHELL': '/bin/bash', 03:43:51 INFO - 'SHLVL': '1', 03:43:51 INFO - 'TERM': 'linux', 03:43:51 INFO - 'TMOUT': '86400', 03:43:51 INFO - 'USER': 'cltbld', 03:43:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', 03:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:51 INFO - '_': '/tools/buildbot/bin/python'} 03:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:51 INFO - Downloading/unpacking psutil>=3.1.1 03:43:51 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 03:43:51 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 03:43:51 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 03:43:51 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 03:43:51 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 03:43:51 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 03:43:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:43:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:53 INFO - Installing collected packages: psutil 03:43:53 INFO - Running setup.py install for psutil 03:43:53 INFO - building 'psutil._psutil_linux' extension 03:43:53 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 03:43:53 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 03:43:53 INFO - building 'psutil._psutil_posix' extension 03:43:53 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 03:43:53 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 03:43:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:53 INFO - Successfully installed psutil 03:43:53 INFO - Cleaning up... 03:43:53 INFO - Return code: 0 03:43:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:53 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 0x1506030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c53b0>, '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 0x17c62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c6740>, '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': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', '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 03:43:53 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 03:43:53 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 03:43:53 INFO - Using env: {'DISPLAY': ':0', 03:43:53 INFO - 'HOME': '/home/cltbld', 03:43:53 INFO - 'LANG': 'en_US.UTF-8', 03:43:53 INFO - 'LANGUAGE': 'en_US:en', 03:43:53 INFO - 'LOGNAME': 'cltbld', 03:43:53 INFO - 'MAIL': '/var/mail/cltbld', 03:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:53 INFO - 'MOZ_NO_REMOTE': '1', 03:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:53 INFO - 'NO_EM_RESTART': '1', 03:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:53 INFO - 'PWD': '/builds/slave/test', 03:43:53 INFO - 'SHELL': '/bin/bash', 03:43:53 INFO - 'SHLVL': '1', 03:43:53 INFO - 'TERM': 'linux', 03:43:53 INFO - 'TMOUT': '86400', 03:43:53 INFO - 'USER': 'cltbld', 03:43:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', 03:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:53 INFO - '_': '/tools/buildbot/bin/python'} 03:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:43:54 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 03:43:54 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 03:43:54 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 03:43:54 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 03:43:54 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 03:43:54 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 03:43:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:43:56 INFO - Installing collected packages: mozsystemmonitor 03:43:56 INFO - Running setup.py install for mozsystemmonitor 03:43:56 INFO - Successfully installed mozsystemmonitor 03:43:56 INFO - Cleaning up... 03:43:56 INFO - Return code: 0 03:43:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:43:56 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')]} 03:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:56 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')]} 03:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:56 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 0x1506030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c53b0>, '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 0x17c62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c6740>, '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': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', '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 03:43:56 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 03:43:56 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 03:43:56 INFO - Using env: {'DISPLAY': ':0', 03:43:56 INFO - 'HOME': '/home/cltbld', 03:43:56 INFO - 'LANG': 'en_US.UTF-8', 03:43:56 INFO - 'LANGUAGE': 'en_US:en', 03:43:56 INFO - 'LOGNAME': 'cltbld', 03:43:56 INFO - 'MAIL': '/var/mail/cltbld', 03:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:56 INFO - 'MOZ_NO_REMOTE': '1', 03:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:56 INFO - 'NO_EM_RESTART': '1', 03:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:56 INFO - 'PWD': '/builds/slave/test', 03:43:56 INFO - 'SHELL': '/bin/bash', 03:43:56 INFO - 'SHLVL': '1', 03:43:56 INFO - 'TERM': 'linux', 03:43:56 INFO - 'TMOUT': '86400', 03:43:56 INFO - 'USER': 'cltbld', 03:43:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', 03:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:56 INFO - '_': '/tools/buildbot/bin/python'} 03:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:56 INFO - Downloading/unpacking jsonschema==2.5.1 03:43:56 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 03:43:56 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 03:43:56 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 03:43:56 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 03:43:56 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 03:43:56 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 03:43:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:43:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:43:58 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 03:43:58 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 03:43:58 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 03:43:58 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 03:43:58 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 03:43:58 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 03:43:58 INFO - Downloading functools32-3.2.3-2.tar.gz 03:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:43:58 INFO - warning: no files found matching '*.txt' 03:43:58 INFO - no previously-included directories found matching 'build' 03:43:58 INFO - no previously-included directories found matching 'dist' 03:43:58 INFO - no previously-included directories found matching '.git*' 03:43:58 INFO - Installing collected packages: jsonschema, functools32 03:43:58 INFO - Running setup.py install for functools32 03:43:58 INFO - warning: no files found matching '*.txt' 03:43:58 INFO - no previously-included directories found matching 'build' 03:43:58 INFO - no previously-included directories found matching 'dist' 03:43:58 INFO - no previously-included directories found matching '.git*' 03:43:58 INFO - Successfully installed jsonschema functools32 03:43:58 INFO - Cleaning up... 03:43:58 INFO - Return code: 0 03:43:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:43:58 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')]} 03:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:58 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')]} 03:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:58 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 0x1506030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c53b0>, '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 0x17c62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c6740>, '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': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', '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 03:43:58 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 03:43:58 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 03:43:58 INFO - Using env: {'DISPLAY': ':0', 03:43:58 INFO - 'HOME': '/home/cltbld', 03:43:58 INFO - 'LANG': 'en_US.UTF-8', 03:43:58 INFO - 'LANGUAGE': 'en_US:en', 03:43:58 INFO - 'LOGNAME': 'cltbld', 03:43:58 INFO - 'MAIL': '/var/mail/cltbld', 03:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:58 INFO - 'MOZ_NO_REMOTE': '1', 03:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:58 INFO - 'NO_EM_RESTART': '1', 03:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:58 INFO - 'PWD': '/builds/slave/test', 03:43:58 INFO - 'SHELL': '/bin/bash', 03:43:58 INFO - 'SHLVL': '1', 03:43:58 INFO - 'TERM': 'linux', 03:43:58 INFO - 'TMOUT': '86400', 03:43:58 INFO - 'USER': 'cltbld', 03:43:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', 03:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:58 INFO - '_': '/tools/buildbot/bin/python'} 03:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:58 INFO - Downloading/unpacking blobuploader==1.2.4 03:43:58 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 03:43:58 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 03:43:58 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 03:43:58 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 03:43:58 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 03:43:58 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 03:44:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:44:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:44:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:44:01 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 03:44:01 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 03:44:01 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 03:44:01 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 03:44:01 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 03:44:01 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 03:44:01 INFO - Downloading docopt-0.6.1.tar.gz 03:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:44:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:44:01 INFO - Running setup.py install for blobuploader 03:44:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:44:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:44:01 INFO - Running setup.py install for requests 03:44:02 INFO - Running setup.py install for docopt 03:44:02 INFO - Successfully installed blobuploader requests docopt 03:44:02 INFO - Cleaning up... 03:44:02 INFO - Return code: 0 03:44:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:02 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 0x1506030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c53b0>, '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 0x17c62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c6740>, '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': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', '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 03:44:02 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 03:44:02 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 03:44:02 INFO - Using env: {'DISPLAY': ':0', 03:44:02 INFO - 'HOME': '/home/cltbld', 03:44:02 INFO - 'LANG': 'en_US.UTF-8', 03:44:02 INFO - 'LANGUAGE': 'en_US:en', 03:44:02 INFO - 'LOGNAME': 'cltbld', 03:44:02 INFO - 'MAIL': '/var/mail/cltbld', 03:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:02 INFO - 'MOZ_NO_REMOTE': '1', 03:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:02 INFO - 'NO_EM_RESTART': '1', 03:44:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:02 INFO - 'PWD': '/builds/slave/test', 03:44:02 INFO - 'SHELL': '/bin/bash', 03:44:02 INFO - 'SHLVL': '1', 03:44:02 INFO - 'TERM': 'linux', 03:44:02 INFO - 'TMOUT': '86400', 03:44:02 INFO - 'USER': 'cltbld', 03:44:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', 03:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:02 INFO - '_': '/tools/buildbot/bin/python'} 03:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:02 INFO - Running setup.py (path:/tmp/pip-y5eujo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:02 INFO - Running setup.py (path:/tmp/pip-DxZtSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:02 INFO - Running setup.py (path:/tmp/pip-TKpcV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:02 INFO - Running setup.py (path:/tmp/pip-7spZH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:02 INFO - Running setup.py (path:/tmp/pip-u74iwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:02 INFO - Running setup.py (path:/tmp/pip-5eZYEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:02 INFO - Running setup.py (path:/tmp/pip-S_CfWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:03 INFO - Running setup.py (path:/tmp/pip-t_vpm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:03 INFO - Running setup.py (path:/tmp/pip-OuocOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:03 INFO - Running setup.py (path:/tmp/pip-SW2xV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:03 INFO - Running setup.py (path:/tmp/pip-9knOio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:03 INFO - Running setup.py (path:/tmp/pip-aG1QZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:03 INFO - Running setup.py (path:/tmp/pip-q58pUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:03 INFO - Running setup.py (path:/tmp/pip-8h4wsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:03 INFO - Running setup.py (path:/tmp/pip-j3hnPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:03 INFO - Running setup.py (path:/tmp/pip-OijPjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:03 INFO - Running setup.py (path:/tmp/pip-qOcsI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:44:03 INFO - Running setup.py install for manifestparser 03:44:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:44:03 INFO - Running setup.py install for mozcrash 03:44:03 INFO - Running setup.py install for mozdebug 03:44:04 INFO - Running setup.py install for mozdevice 03:44:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:44:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:44:04 INFO - Running setup.py install for mozfile 03:44:04 INFO - Running setup.py install for mozhttpd 03:44:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:44:04 INFO - Running setup.py install for mozinfo 03:44:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:44:04 INFO - Running setup.py install for mozInstall 03:44:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:44:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:44:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:44:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:44:04 INFO - Running setup.py install for mozleak 03:44:04 INFO - Running setup.py install for mozlog 03:44:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:44:04 INFO - Running setup.py install for moznetwork 03:44:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:44:04 INFO - Running setup.py install for mozprocess 03:44:04 INFO - Running setup.py install for mozprofile 03:44:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:44:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:44:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:44:05 INFO - Running setup.py install for mozrunner 03:44:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:44:05 INFO - Running setup.py install for mozscreenshot 03:44:05 INFO - Running setup.py install for moztest 03:44:05 INFO - Running setup.py install for mozversion 03:44:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:44:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:44:05 INFO - Cleaning up... 03:44:05 INFO - Return code: 0 03:44:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:05 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')]} 03:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:05 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')]} 03:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:05 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 0x1506030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c53b0>, '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 0x17c62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c6740>, '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': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', '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 03:44:05 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 03:44:05 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 03:44:05 INFO - Using env: {'DISPLAY': ':0', 03:44:05 INFO - 'HOME': '/home/cltbld', 03:44:05 INFO - 'LANG': 'en_US.UTF-8', 03:44:05 INFO - 'LANGUAGE': 'en_US:en', 03:44:05 INFO - 'LOGNAME': 'cltbld', 03:44:05 INFO - 'MAIL': '/var/mail/cltbld', 03:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:05 INFO - 'MOZ_NO_REMOTE': '1', 03:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:05 INFO - 'NO_EM_RESTART': '1', 03:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:05 INFO - 'PWD': '/builds/slave/test', 03:44:05 INFO - 'SHELL': '/bin/bash', 03:44:05 INFO - 'SHLVL': '1', 03:44:05 INFO - 'TERM': 'linux', 03:44:05 INFO - 'TMOUT': '86400', 03:44:05 INFO - 'USER': 'cltbld', 03:44:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', 03:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:05 INFO - '_': '/tools/buildbot/bin/python'} 03:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:05 INFO - Running setup.py (path:/tmp/pip-SlV04E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:05 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)) 03:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:05 INFO - Running setup.py (path:/tmp/pip-4IXYQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:05 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)) 03:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:05 INFO - Running setup.py (path:/tmp/pip-3nxVwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:05 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)) 03:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:05 INFO - Running setup.py (path:/tmp/pip-CHqF84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:06 INFO - Running setup.py (path:/tmp/pip-D53gUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:06 INFO - Running setup.py (path:/tmp/pip-sLSomo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:06 INFO - Running setup.py (path:/tmp/pip-TMq5LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:06 INFO - Running setup.py (path:/tmp/pip-DuJI1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:06 INFO - Running setup.py (path:/tmp/pip-WH9jII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:06 INFO - Running setup.py (path:/tmp/pip-0aPQg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:06 INFO - Running setup.py (path:/tmp/pip-J5GGlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:06 INFO - Running setup.py (path:/tmp/pip-Ru4C_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:06 INFO - Running setup.py (path:/tmp/pip-AZFzUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:06 INFO - Running setup.py (path:/tmp/pip-UMQDt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:06 INFO - Running setup.py (path:/tmp/pip-EsV9WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:06 INFO - Running setup.py (path:/tmp/pip-NJaU7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:06 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)) 03:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:06 INFO - Running setup.py (path:/tmp/pip-9ZA1RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:07 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)) 03:44:07 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)) 03:44:07 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)) 03:44:07 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)) 03:44:07 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)) 03:44:07 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)) 03:44:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44:07 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 03:44:07 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 03:44:07 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 03:44:07 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 03:44:07 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 03:44:07 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 03:44:08 INFO - Downloading blessings-1.6.tar.gz 03:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:09 INFO - Installing collected packages: blessings 03:44:09 INFO - Running setup.py install for blessings 03:44:09 INFO - Successfully installed blessings 03:44:09 INFO - Cleaning up... 03:44:09 INFO - Return code: 0 03:44:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:09 INFO - Reading from file tmpfile_stdout 03:44:09 INFO - Current package versions: 03:44:09 INFO - argparse == 1.2.1 03:44:09 INFO - blessings == 1.6 03:44:09 INFO - blobuploader == 1.2.4 03:44:09 INFO - docopt == 0.6.1 03:44:09 INFO - functools32 == 3.2.3-2 03:44:09 INFO - jsonschema == 2.5.1 03:44:09 INFO - manifestparser == 1.1 03:44:09 INFO - mozInstall == 1.12 03:44:09 INFO - mozcrash == 0.17 03:44:09 INFO - mozdebug == 0.1 03:44:09 INFO - mozdevice == 0.48 03:44:09 INFO - mozfile == 1.2 03:44:09 INFO - mozhttpd == 0.7 03:44:09 INFO - mozinfo == 0.9 03:44:09 INFO - mozleak == 0.1 03:44:09 INFO - mozlog == 3.2 03:44:09 INFO - moznetwork == 0.27 03:44:09 INFO - mozprocess == 0.22 03:44:09 INFO - mozprofile == 0.28 03:44:09 INFO - mozrunner == 6.11 03:44:09 INFO - mozscreenshot == 0.1 03:44:09 INFO - mozsystemmonitor == 0.3 03:44:09 INFO - moztest == 0.7 03:44:09 INFO - mozversion == 1.4 03:44:09 INFO - psutil == 3.1.1 03:44:09 INFO - requests == 1.2.3 03:44:09 INFO - wsgiref == 0.1.2 03:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:09 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')]} 03:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:09 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')]} 03:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:09 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 0x1506030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c53b0>, '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 0x17c62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c6740>, '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': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', '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 03:44:09 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 03:44:09 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 03:44:09 INFO - Using env: {'DISPLAY': ':0', 03:44:09 INFO - 'HOME': '/home/cltbld', 03:44:09 INFO - 'LANG': 'en_US.UTF-8', 03:44:09 INFO - 'LANGUAGE': 'en_US:en', 03:44:09 INFO - 'LOGNAME': 'cltbld', 03:44:09 INFO - 'MAIL': '/var/mail/cltbld', 03:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:09 INFO - 'MOZ_NO_REMOTE': '1', 03:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:09 INFO - 'NO_EM_RESTART': '1', 03:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:09 INFO - 'PWD': '/builds/slave/test', 03:44:09 INFO - 'SHELL': '/bin/bash', 03:44:09 INFO - 'SHLVL': '1', 03:44:09 INFO - 'TERM': 'linux', 03:44:09 INFO - 'TMOUT': '86400', 03:44:09 INFO - 'USER': 'cltbld', 03:44:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', 03:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:09 INFO - '_': '/tools/buildbot/bin/python'} 03:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:09 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)) 03:44:09 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)) 03:44:09 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)) 03:44:09 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)) 03:44:09 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)) 03:44:09 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)) 03:44:09 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)) 03:44:09 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)) 03:44:09 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)) 03:44:09 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)) 03:44:09 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)) 03:44:09 INFO - Cleaning up... 03:44:09 INFO - Return code: 0 03:44:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:09 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')]} 03:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:09 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')]} 03:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:09 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 0x1506030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c53b0>, '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 0x17c62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c6740>, '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': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', '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 03:44:09 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 03:44:09 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 03:44:09 INFO - Using env: {'DISPLAY': ':0', 03:44:09 INFO - 'HOME': '/home/cltbld', 03:44:09 INFO - 'LANG': 'en_US.UTF-8', 03:44:09 INFO - 'LANGUAGE': 'en_US:en', 03:44:09 INFO - 'LOGNAME': 'cltbld', 03:44:09 INFO - 'MAIL': '/var/mail/cltbld', 03:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:09 INFO - 'MOZ_NO_REMOTE': '1', 03:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:09 INFO - 'NO_EM_RESTART': '1', 03:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:09 INFO - 'PWD': '/builds/slave/test', 03:44:09 INFO - 'SHELL': '/bin/bash', 03:44:09 INFO - 'SHLVL': '1', 03:44:09 INFO - 'TERM': 'linux', 03:44:09 INFO - 'TMOUT': '86400', 03:44:09 INFO - 'USER': 'cltbld', 03:44:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', 03:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:09 INFO - '_': '/tools/buildbot/bin/python'} 03:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:44:09 INFO - Cleaning up... 03:44:09 INFO - Return code: 0 03:44:09 INFO - Running post-action listener: _resource_record_post_action 03:44:09 INFO - Running post-action listener: _start_resource_monitoring 03:44:09 INFO - Starting resource monitoring. 03:44:09 INFO - ##### 03:44:09 INFO - ##### Finished create-virtualenv step (success) 03:44:09 INFO - ##### 03:44:09 INFO - ##### 03:44:09 INFO - ##### Running install step. 03:44:09 INFO - ##### 03:44:09 INFO - Running pre-action listener: _resource_record_pre_action 03:44:09 INFO - Running main action method: install 03:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:10 INFO - Reading from file tmpfile_stdout 03:44:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:10 INFO - Reading from file tmpfile_stdout 03:44:10 INFO - Output received: 03:44:10 INFO - Usage: mozinstall [options] installer 03:44:10 INFO - Options: 03:44:10 INFO - -h, --help show this help message and exit 03:44:10 INFO - -d DEST, --destination=DEST 03:44:10 INFO - Directory to install application into. [default: 03:44:10 INFO - "/builds/slave/test"] 03:44:10 INFO - --app=APP Application being installed. [default: firefox] 03:44:10 INFO - mkdir: /builds/slave/test/build/application 03:44:10 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'] 03:44:10 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 03:44:26 INFO - Reading from file tmpfile_stdout 03:44:26 INFO - Output received: 03:44:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:44:26 INFO - Running post-action listener: _resource_record_post_action 03:44:26 INFO - ##### 03:44:26 INFO - ##### Finished install step (success) 03:44:26 INFO - ##### 03:44:26 INFO - ##### 03:44:26 INFO - ##### Running run-tests step. 03:44:26 INFO - ##### 03:44:26 INFO - Running pre-action listener: _resource_record_pre_action 03:44:26 INFO - Running main action method: run_tests 03:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:26 INFO - Python 2.7.3 03:44:26 INFO - Return code: 0 03:44:26 INFO - grabbing minidump binary from tooltool 03:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c53b0>, '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 0x17c62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:44:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:44:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:44:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:26 INFO - Return code: 0 03:44:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:44:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:44:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 03:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 03:44:26 INFO - Using env: {'DISPLAY': ':0', 03:44:26 INFO - 'HOME': '/home/cltbld', 03:44:26 INFO - 'LANG': 'en_US.UTF-8', 03:44:26 INFO - 'LANGUAGE': 'en_US:en', 03:44:26 INFO - 'LOGNAME': 'cltbld', 03:44:26 INFO - 'MAIL': '/var/mail/cltbld', 03:44:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:26 INFO - 'MOZ_NO_REMOTE': '1', 03:44:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:26 INFO - 'NO_EM_RESTART': '1', 03:44:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:26 INFO - 'PWD': '/builds/slave/test', 03:44:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:26 INFO - 'SHELL': '/bin/bash', 03:44:26 INFO - 'SHLVL': '1', 03:44:26 INFO - 'TERM': 'linux', 03:44:26 INFO - 'TMOUT': '86400', 03:44:26 INFO - 'USER': 'cltbld', 03:44:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467369815.289176-1036070337', 03:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:26 INFO - '_': '/tools/buildbot/bin/python'} 03:44:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 03:44:26 INFO - mozversion application_buildid: 20160701021823 03:44:26 INFO - mozversion application_changeset: fdcee57b4e4f66a82831ab01e61500da98a858e8 03:44:26 INFO - mozversion application_display_name: Nightly 03:44:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:26 INFO - mozversion application_name: Firefox 03:44:26 INFO - mozversion application_remotingname: firefox 03:44:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:44:26 INFO - mozversion application_vendor: Mozilla 03:44:26 INFO - mozversion application_version: 50.0a1 03:44:26 INFO - mozversion platform_buildid: 20160701021823 03:44:26 INFO - mozversion platform_changeset: fdcee57b4e4f66a82831ab01e61500da98a858e8 03:44:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:44:26 INFO - mozversion platform_version: 50.0a1 03:44:26 INFO - using testdate: 1467369866 03:44:26 INFO - actual date: 1467369866 03:44:26 INFO - starting webserver on 'localhost:57243' 03:44:26 INFO - SUITE-START | Running 2 tests 03:44:26 INFO - TEST-START | dromaeo_css 03:44:26 INFO - operating with platform_type : linux_ 03:44:26 INFO - Initialising browser for dromaeo_css test... 03:44:26 INFO - TEST-INFO | started process 30971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRxsXah/profile http://localhost:57243/getInfo.html) 03:44:31 INFO - PROCESS | 30971 | __metrics Screen width/height:1600/1200 03:44:31 INFO - PROCESS | 30971 | colorDepth:24 03:44:31 INFO - PROCESS | 30971 | Browser inner width/height: 1024/697 03:44:31 INFO - PROCESS | 30971 | __metrics 03:44:32 INFO - PROCESS | 30971 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:44:33 INFO - TEST-INFO | 30971: exit 0 03:44:33 INFO - Browser initialized. 03:44:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:44:33 INFO - TEST-INFO | started process 31050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRxsXah/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:45 INFO - PROCESS | 31050 | RSS: Main: 158658560 03:44:45 INFO - PROCESS | 31050 | 03:45:36 INFO - PROCESS | 31050 | 1467369936391 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] 03:47:49 INFO - PROCESS | 31050 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57243/tests/dromaeo/cssquery-ext.html) 03:47:50 INFO - PROCESS | 31050 | RSS: Main: 248500224 03:47:50 INFO - PROCESS | 31050 | 03:50:53 INFO - PROCESS | 31050 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-ext.html (next: http://localhost:57243/tests/dromaeo/cssquery-jquery.html) 03:50:53 INFO - PROCESS | 31050 | RSS: Main: 242679808 03:50:53 INFO - PROCESS | 31050 | 03:53:55 INFO - PROCESS | 31050 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57243/tests/dromaeo/cssquery-mootools.html) 03:53:56 INFO - PROCESS | 31050 | RSS: Main: 251146240 03:53:56 INFO - PROCESS | 31050 | 03:56:58 INFO - PROCESS | 31050 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57243/tests/dromaeo/cssquery-prototype.html) 03:56:59 INFO - PROCESS | 31050 | RSS: Main: 241950720 03:56:59 INFO - PROCESS | 31050 | 04:00:02 INFO - PROCESS | 31050 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57243/tests/dromaeo/cssquery-yui.html) 04:00:02 INFO - PROCESS | 31050 | RSS: Main: 217640960 04:00:02 INFO - PROCESS | 31050 | 04:03:05 INFO - PROCESS | 31050 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-yui.html (next: http://localhost:57243/tests/dromaeo/cssquery-dojo.html) 04:03:05 INFO - PROCESS | 31050 | RSS: Main: 298606592 04:03:05 INFO - PROCESS | 31050 | 04:03:05 INFO - PROCESS | 31050 | __start_tp_report 04:03:05 INFO - PROCESS | 31050 | _x_x_mozilla_page_load 04:03:05 INFO - PROCESS | 31050 | _x_x_mozilla_page_load_details 04:03:05 INFO - PROCESS | 31050 | |i|pagename|runs| 04:03:05 INFO - PROCESS | 31050 | |0;dojo.html;2623.8163328567002;2634.3019099938506;2662.6937902141253;2673.719259477756;2678.183154137987;4650.7442090685;4740.881477963053;4751.738654374008;4791.281307803831;4866.610671146309;4790.832320868771;4796.136695394827;4799.37608110946;4802.54375834296;4813.253945638432;4341.044970106579;4387.188370151533;4437.0682156747125;4454.0646464242545;4510;4426.402435671192;4456.442944631921;4473.038296766194;4484.2376795944765;4508.819647214107;4290.892727681818;4346.76092814895;4350.108227813291;4354.629856462205;4404.361367601712;4343.4787825460835;4355.281378572532;4408.801603927831;4409.316555933835;4413.205622987861;4385.320275357325;4389.824407023715;4392.143532011227;4409.426774519292;4441.356003379492;4624.329472226508;4753.239481682948;4817.229243321051;4874.2201247800185;4890.73100979446;5172.120739474299;5174.586033117342;5204.42751297357;5222.529972302473;5223.869403264911;4991.500849915015;5067.771950262247;5214.165733482662;5228.163493840967;5229.189475631283;4788.1381351356395;4862.07620552094;4869.050535145683;4876.780544875489;4888.2178851383605;5325.8934821303355;5330.333708286465;5331.893362132736;5334.226537152092;5334.51989320963;4904.411470623548;4949;5017.899642007213;5071.847844564669;5079.161938280143;5119.385673719177;5128.307678463434;5166.45752196014;5166.535011848951;5172.9741351293005;5077.416097148875;5078.568321692697;5090.550671538497;5097.082525145435;5136.820211292662;4885.877853053631;5040.84877453677;5067.366579177603;5140;5156.226566015128;4079.3676980068135;4093.058596522757;4095.610916962884;4097.549269580344;4137.710360274812;3614.6566076222716;3622.239329740731;3641.10792855752;3647.708183345326;3656.725745569093;4275.230458517497;4312.5903039211225;4324.286492728727;4368.978155109267;4380.255356589388;5139.357580302462;5171.612129090258;5173.560247379015;5181.3782346118705;5228.346456692913;4364.5635436456105;4369.43197384338;4378;4383.1452866691325;4422.557744225616;4532.0482698632995;4545.272756358967;4553.043860789271;4574.931376029363;4609.055143695535;4785.090832741768;4797.808087676453;4803.831865884677;4806.086843499724;4863.027394521039;4981.875453113556;5105.234214867651;5109.693418394908;5122.564582010571;5177.948220517746;4788;4812.807487700453;4848.32123502717;4884.8290309838985;4886.438059623189;5018.322526458881;5021.974890125673;5067.569256613082;5100.107481190703;5139.588832893285;4981.3026176334615;5031.572316353005;5193.61047921415;5204.713740744144;5204.947950520446;4917.213245880642;4961.776720047678;4983;4987.276844857548;5025.271335656383;4947.925781113358;4973.254011898244;4981.227909674007;4993.875153121201;5046.520580544842;4773.212419950669;4886.071646387175;4906.607471402351;4949.455559888482;4954;5079.136546787129;5098.770555324945;5108.28484012246;5111.795528178831;5138.383393992595;4982.701037937735;5001.724905130252;5002.774875130555;5002.949970500394;5051.141305977919 04:03:05 INFO - PROCESS | 31050 | |1;ext.html;576.6568891509552;583.6731430398975;589.6167491130761;592.6947621974684;593.1488314269025;27817.721822781765;40341;41487;41602.37596436052;44491.77754111233;40458;40929.386059209064;40931;40955.79522102393;41081.38377924333;7426.62866856655;7913.762587122395;8054.194580541928;8062.596870156469;8070;7407.666655000511;7642.426817988645;7649.885251721229;10016.54925528353;10379.89620103797;10488.318259313159;10518.263721539495;10526.631567895087;10538;10546.736331591695;10263.589456421734;10289.588416463332;10353.378797272188;10360.378377297386;10365.118964888032;7508.662110205054;7718.922810771876;7730.7680769577;9850.359726617748;10259.17926565873;39089.41365879514;39400.802995984835;39439.211215775525;39486.40770388446;39509.20981580352;3113.252819323369;3323.601167859848;3354.8658053677823;3384.8307584620916;3502.94911526541;29264;29278.414431711248;29709.635436145392;30049.248768780737;31245.843770781226;3304.206990322329;3443.5523381960434;3448.2241495663525;3450.706689931359;3487.1979444727854;254247;254398;254787;255148;257661;53063.46936530585;53711.73144134254;53835;53846.46153538493;53866;57674;57771.422285777444;57783.13325300124;57880;57897.13154302689;14273.857261427253;14675.412983480755;14700.852991470163;14717.411303547953;14747.262636868114;10420.114290285259;11368.261063030877;11409.771804564029;11460.369679667698;11460.426978651034;15903.761443578356;16438.835611643968;16458.506244812674;16706;16745.33018679239;5520.613557051048;5534.086875665551;5551.833444996657;5584.190292407578;5619.887602247933;809.3969992355615;828.8632375658069;908.1644886704248;922.754281719673;932.7201839448275;28475;28626.856865715956;28710.425791484053;28767.56848647272;29175.562366564518;928.5310917986374;942.2838642631649;965.4207475514635;978.500964508106;1032.4166845732288;15678;16360.509184724477;16391.344346226255;17039.48881533556;17298.65402691939;393889;394779;396169;396725;397272;49271;49348.75325623349;49443.258351124765;49505;49560.50439495559;1081.6754973507916;1110.2062025651699;1168.5851522709315;1217.0811037666683;1223.0460241012024;27177.320566985192;28695.569566456936;29116.7088329114;29479.26301842385;29681.25796855096;41903.58096419119;42248.78875605603;42361.57638423576;42369.78815106028;42428.57571424246;307473;307546;308025;308911;309133;23812;24473.143439979514;25129.497410052063;25527.234182974542;25554.23337299884;41368.37947430851;41659.58340416557;41977;42180.78909605432;42875.14249714926;34534.30931381308;35345.469817953264;36174.27651447009;36297;36365.45451818278;35987.280254395286;36121.63878361288;36234.27531449409;36683.44974825433;37020;35193.82403087968;35327.646723533464;37186.62813371832;38055.238895222494;38101;31429.799914005802;33818.66181338155;33824.49263261004;33854.661453386136;34052.65947340495;25689;27300.31749206286;27633.447331053667;27816.582751259153;27911 04:03:05 INFO - PROCESS | 31050 | |2;jquery.html;366.52717993788013;368.44365008836667;372.16263407333497;386.47439482304077;386.5747677554688;16422.26099825508;17037;17732.64534709305;17752.378666746667;17752.64494710105;15962.600934976632;16988.32046718133;17321.566960825985;17694.82305176948;17717.1141442928;4659.813607455706;4851.029794041188;4881.8535443936735;4882.829100981467;4886.096072226632;3523.260115375774;3688.299223147607;4774.641901857357;5748.45389687979;6061.151438798572;6090;6099.390060993909;6122.938770612282;6140.877182456348;6141.385861413867;5416.972915135439;5476.3702174250075;5477.780888764464;5480.26016487773;5558.305211848519;3410.18155642644;5084.898302033976;5288.048151332759;5352.91970620441;5364.329458817648;12772.936135319356;12783.872161278361;12894.032947528973;15325.616859578487;21474.463138421663;1821.6083542038525;1853.7590113285187;1856.2760523395887;1938.8545859060628;2032.7459067616549;9669.419834809934;9743.610255589769;13214.801777973338;13601.523946661819;13858.792118118236;1771.0878897367866;1788.5081602559271;1821.8087100854484;1840.935567255153;1849.843847595253;68367.31632683708;70020.53285506608;70932.2906770936;71983.64008179978;72922.63538682325;10063.194944404577;10196.3372380795;10220.744481388025;10255.94872025635;10556;14018.228997405036;14127.293635318192;14132;14145.787813182811;14173.645658858612;7270.935175874369;7512.737054203077;7523.473356865076;7690;7772.261635144652;6856;7108;7196.698488464661;7213.098362704662;7273.381762550137;4313.352997050468;4423.8009289581405;4440.666949978765;4505.842295519641;4519.909601807945;1633.8039435267606;1734.8612111031086;1763.5943732941496;1820.5642359387898;1851.6389304085844;763.2939530933864;831.2103501673434;862.5945805471418;880.5245167609547;967.8935317115112;16889.071101089557;17076.658466830842;17177.828221717624;17344.306227751;17724.468265951786;844.0757370679097;860.7589874835056;872.1017352127319;882.580774132282;902.747230775384;9577.760555986157;9670.70987870365;9734.172595329477;9738.90261097394;9910;369646.8565029582;376077;377664;400166;402534;74710.62644686742;76577.61711191408;76869;77355.61322193353;77394.2260577387;900.8513595256709;908.2189317187214;909.9818003640023;923.6582464488182;924.9075092490697;15513.224338783242;15571.610709732347;15819.920900395424;15887.602809929844;16157.353705851634;38585;38980.80509597434;39105.6089439102;39693.2061358777;39792.20415591614;52373.21440178324;53119.468805313;53737.46262537324;53797.73101134626;53802.461975379745;7773.650185741768;7779.027621547307;7824.295813376823;8013.919860801318;8014.358851292;11230;12390.62828115158;12444.502219911103;12528;12589;10353.482325883526;10429.16566674649;10442.216833737652;10565.788684226118;10609.8939010612;10420.947895260475;10500.79968012801;10580.100691441314;10699.839502407314;10871.891281087088;10139;10610.257281990187;10639.787204255717;10703.518341674799;10920.726981825517;7768.689252429839;7778.533288002738;7882.802929926797;7951.761447156595;7984.321332686786;7770.067591889009;9081.545922703706;10241;10402.323848949794;10416.32293900894 04:03:05 INFO - PROCESS | 31050 | |3;mootools.html;1387.3548799808086;1403.3474434388008;1508.7661412481064;1683.5791052236941;1707.044055329016;7543.849123017536;8022.799430014238;8122.593870306483;8135.349172066235;8140.552269625168;6810.216825065119;7483.962580187105;7752.573608451533;7753.263439973208;7969.561674107937;2192.7916847899505;2229.320057382498;2231.4086767006756;2232.4195709115666;2232.520008198237;1910.732497450358;2125.1818050050765;2162.081115525903;2184.126349460221;2235.474663454087;2192.561487702466;2235.564065007324;2236.83223758218;2237.2617036377956;2239.3393948785147;2174.63031284682;2187.387531491185;2204.250554811356;2206.801387875083;2207.84088353614;2177.7277840269967;2192.0574153114153;2197.681336206241;2200.9119635214574;2203.9779602203935;8024.317932975704;8064;8092.716754913608;8093.716719914774;8110.459012787552;4502.189605870942;4526.954730452686;4664.743439110847;4665.4168228971375;4675.18184317743;2907.9273018174504;2991.6110905582136;3030.0606811888383;3038.1189455058006;3070.570120183176;968.6997030920437;983.1446641421937;996.496769131584;1015.6546774096843;1015.939043657383;10891.07425868802;10904.400257985808;10914.399708016055;10934.45327733618;10967.83548246777;4127.463429754112;4154.376843473443;4321.243782338078;4321.654267658642;4377.277749171351;9274.397164184307;9275.118863707938;9296.209822165192;9308.255339572817;9308.627654893728;4688.742119183477;4694.460137084211;4704.764761761899;4711.882202944954;4714.033623107255;4211.915761684749;4256.084941737541;4257.8509752158525;4258.723182993095;4262.850800221977;3708.072981754561;3754.1365485938386;3786.3184626766897;3809.12390150267;3838.1364193056897;1106.878243393226;1167.1538134852333;1224.8775122487857;1231.6736064942797;1238.795598726218;620.5159975219336;746.8468963862396;752.9322360987428;779.2558107007794;785.3442375616424;4926.211806111005;4996.350474438373;5096.464871188546;5112.616553758483;5236.450172731808;800.1718221640574;806.9878951815728;850.9872351914727;859.1022381611232;865.2774932930947;3395.813230272359;3482.59950105736;3514.63096374877;3529.4529347951107;3569.5894972078545;9074.818503630022;9345.859812102824;9401.717948461557;9421.481818500048;9450.716478505656;8708.43395179324;9094;9338.393004454689;9348.392354497071;9528.380655257386;7375.336219740249;7476.364509016686;7535.962320188364;7538.170801211862;7544.735934242385;5195.636305458582;5299.099153144052;5393.568514518751;5421.024215641065;5443.59173062014;8886.289096872106;9190.770230744285;9245.19718654856;9264.39781414206;9272.397294175857;8714.085021072697;9136.26909847224;9248.398854074463;9249.861252081359;9289.396189247676;6840.110785597841;6947.79156625302;6976;6987.615681137383;6995.300469952964;7488.326050655467;7548.4716069874585;7574.091109066947;7584.355329797029;7588.165301816685;6389.9680501597195;6410.935890641221;6707.966460167668;6881.759138430331;6886.48351373659;6808.353206445379;6841.863162736817;6901.033855260167;7023.859522809617;7052.18899826506;5711.228984087095;5748.741306641295;5751.568632352507;5758.3090029196765;5765.798197063083;4086.7547947123267;4200.81096350671;4315.266404711144;4340.305551111933;4409.3606427068535;4297.162053399682;4385.912281754411;4406.2068827610055;4457.8439754608435;4497.145542346943 04:03:05 INFO - PROCESS | 31050 | |4;prototype.html;284.44391215174335;292.2576655295549;293.8824470211914;296.6425457323925;299.7871511227029;4819.518048195178;4858;4871.391076115486;4891.951080489194;4941.283513890493;4819.734914579697;4844.636652251078;4844.781984810683;4855.417349918006;4872.658913876021;3653.4885116083838;3725.16183858631;3756.4177552479273;3819.197968426634;3847.230553889219;3805.448210009547;3807.6953843692577;3823.655870971612;3835.884923452287;3843.5195600549932;3608;3789.109559253573;3790.6777923876502;3792.563855156665;3794.203217324365;3658.3414985302634;3757.830897609587;3763.473113764089;3797.6582107610448;3807.866724664651;3370.5281260623533;3372.3086767212662;3376.74674399421;3380.6619338066;3404.8297585120645;4719.905601887977;4720.881977950545;4724.881877953045;4736.668433209677;4741.596964258042;4242;4338.544452832439;4360.760158191299;4369.6185578859595;4371.78141092944;4935.9753201234125;4993.850184494471;5003.74981250936;5033.421156567005;5040.16837221858;3670.6418625108613;3671.614480479538;3672.540932383452;3682.8895133146048;3691.151035261905;5110.259012443212;5245.895082098336;5259.053370393328;5259.737013149365;5260;3753.418220175877;3761.3981762918347;3765.435184722259;3766.7363284569815;3775.981120094382;3799.903078990669;3810.809459527068;3811.904702382463;3826.100866296418;3827.5024246847734;4262.893427664333;4311.568843115726;4312.611864932172;4327.480702315742;4354;4873.829415970424;5032.773525191302;5037;5043.193089105725;5046.697198168122;1303.5307289375817;1315.6184706435217;1325.9602211933657;1327.99736199169;1330.1487048289102;837.7905523619095;843.3927572148043;850.37497439382;891.8528442806864;916.5508900638772;4378.408914796461;4395.494518130392;4396.230659634552;4399.846005389796;4402.163588918095;5095.414027386898;5119.539241468286;5122.103631864484;5127.692338459704;5137.33214682089;4240.936385954213;4365.410669559569;4370.934435983463;4375.912481750347;4378.5183629800695;2751.2021513760783;2761.2130542795207;2772.1031522059498;2774.750272475487;2781.235160330885;4881.95118048822;4889.951100489021;4893.070316639827;4899.113841171104;4922.606191504671;5106.897862042739;5304.09052741013;5306.442823503477;5363.249145119687;5382.892342153135;4924.4090709115135;4940.654154209171;4950.925736113889;4951.950480495221;4963.90072198554;5164.586833053271;5227.529522343008;5240.554552862897;5251.343582052244;5255.737213139251;4896;5174.818881339135;5186;5202.063628546746;5203.297554830049;4930.6795058321095;4947.208446648519;4949.480304567968;4951.9257211142585;4961.925571116509;3672.485851980671;3685.115572262584;3693.6306369362846;3693.796841173761;3708.147126161052;5100.897982040413;5200.323957885451;5215.504527069922;5300.893982120258;5327.467253274642;5012.699238045583;5039.5968322534845;5041.7647676318065;5055.873603159804;5060.3927528696795;5043.646944713835;5070.645054846125;5118.641695081308;5119.667221630582;5131.461196574306;4777.402824646919;5034.0686972910125;5051.4695956924;5059.974700126476;5096.898062038665;4869.735572958592;4981.726005069756;5165.579465646827;5173.896522069613;5185.481451854785;4998;5005.174146265971;5015.699058056528;5023.8696293333705;5092.770825312944 04:03:06 INFO - PROCESS | 31050 | |5;yui.html;657.2015001772846;694.5728377048114;733.0836454431957;742.283696233135;764.6313099551804;11947.7610447791;12281.692957676063;12996.935015324934;13053.086283960127;14948.626284342898;14276.4289428423;14432.711345773077;14439.63900902478;14458.060226085323;14500.057496262736;769.4613770360755;786.2334224131483;787.1695361393728;790.9050913890312;791.7703865878888;627.8147946355836;749.1085608126313;783.0955246690054;787.2953706432739;787.9527228366317;842.4692443760422;845.049319515545;848.5714714069386;848.6902280667542;849.2993280543545;833.6123702478316;834.3492076180589;834.4159088637947;834.4284165346696;834.6369329341755;612.6232367094206;612.7855250662277;612.791650838717;613.5275837605019;613.9969300153515;11116.444177791078;11254.099672026217;11276.43617819114;11277.54889804415;11301.095912326995;13176.868231317756;13442.731145377136;13529.729405411936;13566.728665426635;13717.245551494663;10216.798391431634;10323.277370584063;10533.104686101691;10634.62778802746;10652.573897044109;3372.932541349184;3392.0502259367418;3406.7615266931325;3461.463473161664;3513.2797776455764;60602.696986514784;60940;61179.694101529654;62480;62734.372656273765;9647.421154730739;9912.851307230398;10057.396556206651;10279.537420816081;10468.63359782404;20208.29270975509;20269.391918242476;20304.08631611581;20306.492337691678;20757.377278681663;6907.723691052302;6930.3762661360715;6944.7222111116;7040.295970402919;7112.324329188718;3761.4733937248807;3844.5386553613744;3856.151646637791;3888.4556162137324;3888.949983504438;2883.3656595548946;2979.731824135838;2979.851007449619;2979.955300670492;2984.373281610886;499.8300577803564;510.2524801166309;511.5728366813678;515.3120584020375;520.8775937654648;463.7542102685582;586.8122200895758;621.6554934452616;634.0362648773838;641.7785863876956;8183.795405114801;8345.874811877828;8550.700725474579;8571.357148213909;8660.13398660129;490.029741112599;506.7770181120295;614.2935624032399;616.1866336435861;623.9875202495924;3868.8065596720053;4082.857100001486;4106.589341065869;4126.298529249974;4240.38514415408;59533.10700339499;90879.54560227289;93350;93421.53289233646;93685;49092.52722418333;49260.26109608359;49310.75344623254;50079;50394;59287.071292870365;72967;73020.63489682517;73244.26755732375;75867.62066189744;7718.3053525183;7727.536347819148;7772.183920688246;7795.473595976566;8076.676932922617;29893.551596725632;30559.847200763856;30717.078487645405;31208.843955780078;31326.216844579067;57641.42358576361;64264;64331.67834160799;65726.34273657203;65779;10289.228307876789;10926.125909927347;11317.886821131684;11403.942980285046;11883;12447.93776031114;13200.075994680281;13209.405576749261;13694.041417101105;14226.35981380861;12063.577774777841;12244.081693872817;12693.555725549562;12996.155249908727;13534.79697804514;11631.59289424866;11658.825117623073;11837.526498939946;12499.625011249676;12832.55086071983;12438.685152278626;12561.623151305475;12678.746425071631;12960.481580736665;13271.800922986356;9356.766080848034;9531.809363812823;9753.951230243803;9908.306418550632;10016;9486.573104210465;9827.869794973669;9850.408975461496;9866.901330986599;9888.85166722514 04:03:06 INFO - PROCESS | 31050 | __end_tp_report 04:03:06 INFO - PROCESS | 31050 | __start_cc_report 04:03:06 INFO - PROCESS | 31050 | _x_x_mozilla_cycle_collect,918 04:03:06 INFO - PROCESS | 31050 | __end_cc_report 04:03:06 INFO - PROCESS | 31050 | __startTimestamp1467370985990__endTimestamp 04:03:06 INFO - PROCESS | 31050 | 04:03:06 INFO - PROCESS | 31050 | ------- Summary: start ------- 04:03:06 INFO - PROCESS | 31050 | Number of tests: 6 04:03:06 INFO - PROCESS | 31050 | 04:03:06 INFO - PROCESS | 31050 | [#0] dojo.html Cycles:165 Average:4727.27 Median:4884.83 stddev:526.39 (10.8%) stddev-sans-first:501.48 04:03:06 INFO - PROCESS | 31050 | Values: 2623.8 2634.3 2662.7 2673.7 2678.2 4650.7 4740.9 4751.7 4791.3 4866.6 4790.8 4796.1 4799.4 4802.5 4813.3 4341.0 4387.2 4437.1 4454.1 4510.0 4426.4 4456.4 4473.0 4484.2 4508.8 4290.9 4346.8 4350.1 4354.6 4404.4 4343.5 4355.3 4408.8 4409.3 4413.2 4385.3 4389.8 4392.1 4409.4 4441.4 4624.3 4753.2 4817.2 4874.2 4890.7 5172.1 5174.6 5204.4 5222.5 5223.9 4991.5 5067.8 5214.2 5228.2 5229.2 4788.1 4862.1 4869.1 4876.8 4888.2 5325.9 5330.3 5331.9 5334.2 5334.5 4904.4 4949.0 5017.9 5071.8 5079.2 5119.4 5128.3 5166.5 5166.5 5173.0 5077.4 5078.6 5090.6 5097.1 5136.8 4885.9 5040.8 5067.4 5140.0 5156.2 4079.4 4093.1 4095.6 4097.5 4137.7 3614.7 3622.2 3641.1 3647.7 3656.7 4275.2 4312.6 4324.3 4369.0 4380.3 5139.4 5171.6 5173.6 5181.4 5228.3 4364.6 4369.4 4378.0 4383.1 4422.6 4532.0 4545.3 4553.0 4574.9 4609.1 4785.1 4797.8 4803.8 4806.1 4863.0 4981.9 5105.2 5109.7 5122.6 5177.9 4788.0 4812.8 4848.3 4884.8 4886.4 5018.3 5022.0 5067.6 5100.1 5139.6 4981.3 5031.6 5193.6 5204.7 5204.9 4917.2 4961.8 4983.0 4987.3 5025.3 4947.9 4973.3 4981.2 4993.9 5046.5 4773.2 4886.1 4906.6 4949.5 4954.0 5079.1 5098.8 5108.3 5111.8 5138.4 4982.7 5001.7 5002.8 5002.9 5051.1 04:03:06 INFO - PROCESS | 31050 | 04:03:06 INFO - PROCESS | 31050 | [#1] ext.html Cycles:180 Average:47959.59 Median:19348.39 stddev:85441.70 (441.6%) stddev-sans-first:85607.32 04:03:06 INFO - PROCESS | 31050 | Values: 576.7 583.7 589.6 592.7 593.1 27817.7 40341.0 41487.0 41602.4 44491.8 40458.0 40929.4 40931.0 40955.8 41081.4 7426.6 7913.8 8054.2 8062.6 8070.0 7407.7 7642.4 7649.9 10016.5 10379.9 10488.3 10518.3 10526.6 10538.0 10546.7 10263.6 10289.6 10353.4 10360.4 10365.1 7508.7 7718.9 7730.8 9850.4 10259.2 39089.4 39400.8 39439.2 39486.4 39509.2 3113.3 3323.6 3354.9 3384.8 3502.9 29264.0 29278.4 29709.6 30049.2 31245.8 3304.2 3443.6 3448.2 3450.7 3487.2 254247.0 254398.0 254787.0 255148.0 257661.0 53063.5 53711.7 53835.0 53846.5 53866.0 57674.0 57771.4 57783.1 57880.0 57897.1 14273.9 14675.4 14700.9 14717.4 14747.3 10420.1 11368.3 11409.8 11460.4 11460.4 15903.8 16438.8 16458.5 16706.0 16745.3 5520.6 5534.1 5551.8 5584.2 5619.9 809.4 828.9 908.2 922.8 932.7 28475.0 28626.9 28710.4 28767.6 29175.6 928.5 942.3 965.4 978.5 1032.4 15678.0 16360.5 16391.3 17039.5 17298.7 393889.0 394779.0 396169.0 396725.0 397272.0 49271.0 49348.8 49443.3 49505.0 49560.5 1081.7 1110.2 1168.6 1217.1 1223.0 27177.3 28695.6 29116.7 29479.3 29681.3 41903.6 42248.8 42361.6 42369.8 42428.6 307473.0 307546.0 308025.0 308911.0 309133.0 23812.0 24473.1 25129.5 25527.2 25554.2 41368.4 41659.6 41977.0 42180.8 42875.1 34534.3 35345.5 36174.3 36297.0 36365.5 35987.3 36121.6 36234.3 36683.4 37020.0 35193.8 35327.6 37186.6 38055.2 38101.0 31429.8 33818.7 33824.5 33854.7 34052.7 25689.0 27300.3 27633.4 27816.6 27911.0 04:03:06 INFO - PROCESS | 31050 | 04:03:06 INFO - PROCESS | 31050 | [#2] jquery.html Cycles:180 Average:24358.56 Median:39742.71 stddev:63728.77 (160.4%) stddev-sans-first:63882.09 04:03:06 INFO - PROCESS | 31050 | Values: 366.5 368.4 372.2 386.5 386.6 16422.3 17037.0 17732.6 17752.4 17752.6 15962.6 16988.3 17321.6 17694.8 17717.1 4659.8 4851.0 4881.9 4882.8 4886.1 3523.3 3688.3 4774.6 5748.5 6061.2 6090.0 6099.4 6122.9 6140.9 6141.4 5417.0 5476.4 5477.8 5480.3 5558.3 3410.2 5084.9 5288.0 5352.9 5364.3 12772.9 12783.9 12894.0 15325.6 21474.5 1821.6 1853.8 1856.3 1938.9 2032.7 9669.4 9743.6 13214.8 13601.5 13858.8 1771.1 1788.5 1821.8 1840.9 1849.8 68367.3 70020.5 70932.3 71983.6 72922.6 10063.2 10196.3 10220.7 10255.9 10556.0 14018.2 14127.3 14132.0 14145.8 14173.6 7270.9 7512.7 7523.5 7690.0 7772.3 6856.0 7108.0 7196.7 7213.1 7273.4 4313.4 4423.8 4440.7 4505.8 4519.9 1633.8 1734.9 1763.6 1820.6 1851.6 763.3 831.2 862.6 880.5 967.9 16889.1 17076.7 17177.8 17344.3 17724.5 844.1 860.8 872.1 882.6 902.7 9577.8 9670.7 9734.2 9738.9 9910.0 369646.9 376077.0 377664.0 400166.0 402534.0 74710.6 76577.6 76869.0 77355.6 77394.2 900.9 908.2 910.0 923.7 924.9 15513.2 15571.6 15819.9 15887.6 16157.4 38585.0 38980.8 39105.6 39693.2 39792.2 52373.2 53119.5 53737.5 53797.7 53802.5 7773.7 7779.0 7824.3 8013.9 8014.4 11230.0 12390.6 12444.5 12528.0 12589.0 10353.5 10429.2 10442.2 10565.8 10609.9 10420.9 10500.8 10580.1 10699.8 10871.9 10139.0 10610.3 10639.8 10703.5 10920.7 7768.7 7778.5 7882.8 7951.8 7984.3 7770.1 9081.5 10241.0 10402.3 10416.3 04:03:06 INFO - PROCESS | 31050 | 04:03:06 INFO - PROCESS | 31050 | [#3] mootools.html Cycles:180 Average:5152.36 Median:5154.13 stddev:2895.52 (56.2%) stddev-sans-first:2889.82 04:03:06 INFO - PROCESS | 31050 | Values: 1387.4 1403.3 1508.8 1683.6 1707.0 7543.8 8022.8 8122.6 8135.3 8140.6 6810.2 7484.0 7752.6 7753.3 7969.6 2192.8 2229.3 2231.4 2232.4 2232.5 1910.7 2125.2 2162.1 2184.1 2235.5 2192.6 2235.6 2236.8 2237.3 2239.3 2174.6 2187.4 2204.3 2206.8 2207.8 2177.7 2192.1 2197.7 2200.9 2204.0 8024.3 8064.0 8092.7 8093.7 8110.5 4502.2 4527.0 4664.7 4665.4 4675.2 2907.9 2991.6 3030.1 3038.1 3070.6 968.7 983.1 996.5 1015.7 1015.9 10891.1 10904.4 10914.4 10934.5 10967.8 4127.5 4154.4 4321.2 4321.7 4377.3 9274.4 9275.1 9296.2 9308.3 9308.6 4688.7 4694.5 4704.8 4711.9 4714.0 4211.9 4256.1 4257.9 4258.7 4262.9 3708.1 3754.1 3786.3 3809.1 3838.1 1106.9 1167.2 1224.9 1231.7 1238.8 620.5 746.8 752.9 779.3 785.3 4926.2 4996.4 5096.5 5112.6 5236.5 800.2 807.0 851.0 859.1 865.3 3395.8 3482.6 3514.6 3529.5 3569.6 9074.8 9345.9 9401.7 9421.5 9450.7 8708.4 9094.0 9338.4 9348.4 9528.4 7375.3 7476.4 7536.0 7538.2 7544.7 5195.6 5299.1 5393.6 5421.0 5443.6 8886.3 9190.8 9245.2 9264.4 9272.4 8714.1 9136.3 9248.4 9249.9 9289.4 6840.1 6947.8 6976.0 6987.6 6995.3 7488.3 7548.5 7574.1 7584.4 7588.2 6390.0 6410.9 6708.0 6881.8 6886.5 6808.4 6841.9 6901.0 7023.9 7052.2 5711.2 5748.7 5751.6 5758.3 5765.8 4086.8 4200.8 4315.3 4340.3 4409.4 4297.2 4385.9 4406.2 4457.8 4497.1 04:03:06 INFO - PROCESS | 31050 | 04:03:06 INFO - PROCESS | 31050 | [#4] prototype.html Cycles:180 Average:4216.48 Median:4856.71 stddev:1215.54 (25.0%) stddev-sans-first:1182.58 04:03:06 INFO - PROCESS | 31050 | Values: 284.4 292.3 293.9 296.6 299.8 4819.5 4858.0 4871.4 4892.0 4941.3 4819.7 4844.6 4844.8 4855.4 4872.7 3653.5 3725.2 3756.4 3819.2 3847.2 3805.4 3807.7 3823.7 3835.9 3843.5 3608.0 3789.1 3790.7 3792.6 3794.2 3658.3 3757.8 3763.5 3797.7 3807.9 3370.5 3372.3 3376.7 3380.7 3404.8 4719.9 4720.9 4724.9 4736.7 4741.6 4242.0 4338.5 4360.8 4369.6 4371.8 4936.0 4993.9 5003.7 5033.4 5040.2 3670.6 3671.6 3672.5 3682.9 3691.2 5110.3 5245.9 5259.1 5259.7 5260.0 3753.4 3761.4 3765.4 3766.7 3776.0 3799.9 3810.8 3811.9 3826.1 3827.5 4262.9 4311.6 4312.6 4327.5 4354.0 4873.8 5032.8 5037.0 5043.2 5046.7 1303.5 1315.6 1326.0 1328.0 1330.1 837.8 843.4 850.4 891.9 916.6 4378.4 4395.5 4396.2 4399.8 4402.2 5095.4 5119.5 5122.1 5127.7 5137.3 4240.9 4365.4 4370.9 4375.9 4378.5 2751.2 2761.2 2772.1 2774.8 2781.2 4882.0 4890.0 4893.1 4899.1 4922.6 5106.9 5304.1 5306.4 5363.2 5382.9 4924.4 4940.7 4950.9 4952.0 4963.9 5164.6 5227.5 5240.6 5251.3 5255.7 4896.0 5174.8 5186.0 5202.1 5203.3 4930.7 4947.2 4949.5 4951.9 4961.9 3672.5 3685.1 3693.6 3693.8 3708.1 5100.9 5200.3 5215.5 5300.9 5327.5 5012.7 5039.6 5041.8 5055.9 5060.4 5043.6 5070.6 5118.6 5119.7 5131.5 4777.4 5034.1 5051.5 5060.0 5096.9 4869.7 4981.7 5165.6 5173.9 5185.5 4998.0 5005.2 5015.7 5023.9 5092.8 04:03:06 INFO - PROCESS | 31050 | 04:03:06 INFO - PROCESS | 31050 | [#5] yui.html Cycles:180 Average:16140.94 Median:50236.50 stddev:21823.78 (43.4%) stddev-sans-first:21854.03 04:03:06 INFO - PROCESS | 31050 | Values: 657.2 694.6 733.1 742.3 764.6 11947.8 12281.7 12996.9 13053.1 14948.6 14276.4 14432.7 14439.6 14458.1 14500.1 769.5 786.2 787.2 790.9 791.8 627.8 749.1 783.1 787.3 788.0 842.5 845.0 848.6 848.7 849.3 833.6 834.3 834.4 834.4 834.6 612.6 612.8 612.8 613.5 614.0 11116.4 11254.1 11276.4 11277.5 11301.1 13176.9 13442.7 13529.7 13566.7 13717.2 10216.8 10323.3 10533.1 10634.6 10652.6 3372.9 3392.1 3406.8 3461.5 3513.3 60602.7 60940.0 61179.7 62480.0 62734.4 9647.4 9912.9 10057.4 10279.5 10468.6 20208.3 20269.4 20304.1 20306.5 20757.4 6907.7 6930.4 6944.7 7040.3 7112.3 3761.5 3844.5 3856.2 3888.5 3888.9 2883.4 2979.7 2979.9 2980.0 2984.4 499.8 510.3 511.6 515.3 520.9 463.8 586.8 621.7 634.0 641.8 8183.8 8345.9 8550.7 8571.4 8660.1 490.0 506.8 614.3 616.2 624.0 3868.8 4082.9 4106.6 4126.3 4240.4 59533.1 90879.5 93350.0 93421.5 93685.0 49092.5 49260.3 49310.8 50079.0 50394.0 59287.1 72967.0 73020.6 73244.3 75867.6 7718.3 7727.5 7772.2 7795.5 8076.7 29893.6 30559.8 30717.1 31208.8 31326.2 57641.4 64264.0 64331.7 65726.3 65779.0 10289.2 10926.1 11317.9 11403.9 11883.0 12447.9 13200.1 13209.4 13694.0 14226.4 12063.6 12244.1 12693.6 12996.2 13534.8 11631.6 11658.8 11837.5 12499.6 12832.6 12438.7 12561.6 12678.7 12960.5 13271.8 9356.8 9531.8 9754.0 9908.3 10016.0 9486.6 9827.9 9850.4 9866.9 9888.9 04:03:06 INFO - PROCESS | 31050 | -------- Summary: end -------- 04:03:06 INFO - PROCESS | 31050 | 04:03:06 INFO - TEST-INFO | 31050: exit 0 04:03:06 INFO - TEST-OK | dromaeo_css | took 1120155ms 04:03:06 INFO - TEST-START | kraken 04:03:06 INFO - operating with platform_type : linux_ 04:03:06 INFO - Initialising browser for kraken test... 04:03:06 INFO - TEST-INFO | started process 31255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2uPH4H/profile http://localhost:57243/getInfo.html) 04:03:11 INFO - PROCESS | 31255 | __metrics Screen width/height:1600/1200 04:03:11 INFO - PROCESS | 31255 | colorDepth:24 04:03:11 INFO - PROCESS | 31255 | Browser inner width/height: 1024/697 04:03:11 INFO - PROCESS | 31255 | __metrics 04:03:12 INFO - PROCESS | 31255 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:03:13 INFO - TEST-INFO | 31255: exit 0 04:03:13 INFO - Browser initialized. 04:03:13 INFO - Running cycle 1/1 for kraken test... 04:03:13 INFO - TEST-INFO | started process 31336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2uPH4H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:25 INFO - PROCESS | 31336 | RSS: Main: 158994432 04:03:25 INFO - PROCESS | 31336 | 04:03:28 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57243/tests/kraken/driver.html?testName=audio-beat-detection) 04:03:28 INFO - PROCESS | 31336 | RSS: Main: 216985600 04:03:28 INFO - PROCESS | 31336 | 04:03:31 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57243/tests/kraken/driver.html?testName=audio-dft) 04:03:32 INFO - PROCESS | 31336 | RSS: Main: 203837440 04:03:32 INFO - PROCESS | 31336 | 04:03:35 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57243/tests/kraken/driver.html?testName=audio-fft) 04:03:36 INFO - PROCESS | 31336 | RSS: Main: 271450112 04:03:36 INFO - PROCESS | 31336 | 04:03:38 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57243/tests/kraken/driver.html?testName=audio-oscillator) 04:03:38 INFO - PROCESS | 31336 | RSS: Main: 182185984 04:03:38 INFO - PROCESS | 31336 | 04:03:41 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:03:41 INFO - PROCESS | 31336 | RSS: Main: 185929728 04:03:41 INFO - PROCESS | 31336 | 04:03:44 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57243/tests/kraken/driver.html?testName=imaging-darkroom) 04:03:45 INFO - PROCESS | 31336 | RSS: Main: 221933568 04:03:45 INFO - PROCESS | 31336 | 04:03:48 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57243/tests/kraken/driver.html?testName=imaging-desaturate) 04:03:49 INFO - PROCESS | 31336 | RSS: Main: 222900224 04:03:49 INFO - PROCESS | 31336 | 04:03:52 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57243/tests/kraken/driver.html?testName=json-parse-financial) 04:03:53 INFO - PROCESS | 31336 | RSS: Main: 222818304 04:03:53 INFO - PROCESS | 31336 | 04:03:54 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:03:55 INFO - PROCESS | 31336 | RSS: Main: 210853888 04:03:55 INFO - PROCESS | 31336 | 04:03:57 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:03:57 INFO - PROCESS | 31336 | RSS: Main: 215126016 04:03:57 INFO - PROCESS | 31336 | 04:04:00 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:04:00 INFO - PROCESS | 31336 | RSS: Main: 213250048 04:04:00 INFO - PROCESS | 31336 | 04:04:03 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:04:04 INFO - PROCESS | 31336 | RSS: Main: 225021952 04:04:04 INFO - PROCESS | 31336 | 04:04:06 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:04:07 INFO - PROCESS | 31336 | RSS: Main: 224878592 04:04:07 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57243/tests/kraken/driver.html?testName=ai-astar) 04:04:09 INFO - PROCESS | 31336 | RSS: Main: 266989568 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | __start_tp_report 04:04:09 INFO - PROCESS | 31336 | _x_x_mozilla_page_load 04:04:09 INFO - PROCESS | 31336 | _x_x_mozilla_page_load_details 04:04:09 INFO - PROCESS | 31336 | |i|pagename|runs| 04:04:09 INFO - PROCESS | 31336 | |0;ai-astar;103;115;115;113;114;114;115;113;114;113 04:04:09 INFO - PROCESS | 31336 | |1;audio-beat-detection;149;129;129;183;122;126;156;127;172;126 04:04:09 INFO - PROCESS | 31336 | |2;audio-dft;163;162;162;162;161;162;162;161;163;162 04:04:09 INFO - PROCESS | 31336 | |3;audio-fft;75;76;76;129;76;76;76;75;104;76 04:04:09 INFO - PROCESS | 31336 | |4;audio-oscillator;85;87;120;85;85;85;125;86;85;119 04:04:09 INFO - PROCESS | 31336 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;116;117 04:04:09 INFO - PROCESS | 31336 | |6;imaging-darkroom;147;146;146;146;146;146;147;147;147;146 04:04:09 INFO - PROCESS | 31336 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;96;95 04:04:09 INFO - PROCESS | 31336 | |8;json-parse-financial;63;65;64;65;64;63;64;65;63;63 04:04:09 INFO - PROCESS | 31336 | |9;json-stringify-tinderbox;64;65;65;65;64;64;65;67;66;66 04:04:09 INFO - PROCESS | 31336 | |10;stanford-crypto-aes;88;81;85;78;78;79;78;79;79;81 04:04:09 INFO - PROCESS | 31336 | |11;stanford-crypto-ccm;130;126;128;129;128;127;128;128;209;140 04:04:09 INFO - PROCESS | 31336 | |12;stanford-crypto-pbkdf2;166;171;166;165;163;165;165;163;165;165 04:04:09 INFO - PROCESS | 31336 | |13;stanford-crypto-sha256-iterative;67;67;71;66;66;67;67;67;65;66 04:04:09 INFO - PROCESS | 31336 | __end_tp_report 04:04:09 INFO - PROCESS | 31336 | __start_cc_report 04:04:09 INFO - PROCESS | 31336 | _x_x_mozilla_cycle_collect,1881 04:04:09 INFO - PROCESS | 31336 | __end_cc_report 04:04:09 INFO - PROCESS | 31336 | __startTimestamp1467371049554__endTimestamp 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | ------- Summary: start ------- 04:04:09 INFO - PROCESS | 31336 | Number of tests: 14 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.57 (3.1%) stddev-sans-first:0.87 04:04:09 INFO - PROCESS | 31336 | Values: 103.0 115.0 115.0 113.0 114.0 114.0 115.0 113.0 114.0 113.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:139.00 stddev:21.86 (15.7%) stddev-sans-first:23.03 04:04:09 INFO - PROCESS | 31336 | Values: 149.0 129.0 129.0 183.0 122.0 126.0 156.0 127.0 172.0 126.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 04:04:09 INFO - PROCESS | 31336 | Values: 163.0 162.0 162.0 162.0 161.0 162.0 162.0 161.0 163.0 162.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:18.17 (23.9%) stddev-sans-first:18.98 04:04:09 INFO - PROCESS | 31336 | Values: 75.0 76.0 76.0 129.0 76.0 76.0 76.0 75.0 104.0 76.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:17.42 (20.5%) stddev-sans-first:18.00 04:04:09 INFO - PROCESS | 31336 | Values: 85.0 87.0 120.0 85.0 85.0 85.0 125.0 86.0 85.0 119.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:04:09 INFO - PROCESS | 31336 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:04:09 INFO - PROCESS | 31336 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:04:09 INFO - PROCESS | 31336 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 04:04:09 INFO - PROCESS | 31336 | Values: 63.0 65.0 64.0 65.0 64.0 63.0 64.0 65.0 63.0 63.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 04:04:09 INFO - PROCESS | 31336 | Values: 64.0 65.0 65.0 65.0 64.0 64.0 65.0 67.0 66.0 66.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:3.37 (4.2%) stddev-sans-first:2.28 04:04:09 INFO - PROCESS | 31336 | Values: 88.0 81.0 85.0 78.0 78.0 79.0 78.0 79.0 79.0 81.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:128.50 stddev:25.50 (19.8%) stddev-sans-first:26.90 04:04:09 INFO - PROCESS | 31336 | Values: 130.0 126.0 128.0 129.0 128.0 127.0 128.0 128.0 209.0 140.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:165.00 stddev:2.22 (1.3%) stddev-sans-first:2.35 04:04:09 INFO - PROCESS | 31336 | Values: 166.0 171.0 166.0 165.0 163.0 165.0 165.0 163.0 165.0 165.0 04:04:09 INFO - PROCESS | 31336 | 04:04:09 INFO - PROCESS | 31336 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.60 (2.4%) stddev-sans-first:1.69 04:04:09 INFO - PROCESS | 31336 | Values: 67.0 67.0 71.0 66.0 66.0 67.0 67.0 67.0 65.0 66.0 04:04:09 INFO - PROCESS | 31336 | -------- Summary: end -------- 04:04:09 INFO - PROCESS | 31336 | 04:04:10 INFO - TEST-INFO | 31336: exit 0 04:04:10 INFO - TEST-OK | kraken | took 63768ms 04:04:10 INFO - SUITE-END | took 1183s 04:04:10 INFO - Completed test suite (00:19:44) 04:04:10 INFO - javascript benchmark 04:04:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.8163328567002, 2634.3019099938506, 2662.6937902141253, 2673.719259477756, 2678.183154137987, 4650.7442090685, 4740.881477963053, 4751.738654374008, 4791.281307803831, 4866.610671146309, 4790.832320868771, 4796.136695394827, 4799.37608110946, 4802.54375834296, 4813.253945638432, 4341.044970106579, 4387.188370151533, 4437.0682156747125, 4454.0646464242545, 4510.0, 4426.402435671192, 4456.442944631921, 4473.038296766194, 4484.2376795944765, 4508.819647214107, 4290.892727681818, 4346.76092814895, 4350.108227813291, 4354.629856462205, 4404.361367601712, 4343.4787825460835, 4355.281378572532, 4408.801603927831, 4409.316555933835, 4413.205622987861, 4385.320275357325, 4389.824407023715, 4392.143532011227, 4409.426774519292, 4441.356003379492, 4624.329472226508, 4753.239481682948, 4817.229243321051, 4874.2201247800185, 4890.73100979446, 5172.120739474299, 5174.586033117342, 5204.42751297357, 5222.529972302473, 5223.869403264911, 4991.500849915015, 5067.771950262247, 5214.165733482662, 5228.163493840967, 5229.189475631283, 4788.1381351356395, 4862.07620552094, 4869.050535145683, 4876.780544875489, 4888.2178851383605, 5325.8934821303355, 5330.333708286465, 5331.893362132736, 5334.226537152092, 5334.51989320963, 4904.411470623548, 4949.0, 5017.899642007213, 5071.847844564669, 5079.161938280143, 5119.385673719177, 5128.307678463434, 5166.45752196014, 5166.535011848951, 5172.9741351293005, 5077.416097148875, 5078.568321692697, 5090.550671538497, 5097.082525145435, 5136.820211292662, 4885.877853053631, 5040.84877453677, 5067.366579177603, 5140.0, 5156.226566015128, 4079.3676980068135, 4093.058596522757, 4095.610916962884, 4097.549269580344, 4137.710360274812, 3614.6566076222716, 3622.239329740731, 3641.10792855752, 3647.708183345326, 3656.725745569093, 4275.230458517497, 4312.5903039211225, 4324.286492728727, 4368.978155109267, 4380.255356589388, 5139.357580302462, 5171.612129090258, 5173.560247379015, 5181.3782346118705, 5228.346456692913, 4364.5635436456105, 4369.43197384338, 4378.0, 4383.1452866691325, 4422.557744225616, 4532.0482698632995, 4545.272756358967, 4553.043860789271, 4574.931376029363, 4609.055143695535, 4785.090832741768, 4797.808087676453, 4803.831865884677, 4806.086843499724, 4863.027394521039, 4981.875453113556, 5105.234214867651, 5109.693418394908, 5122.564582010571, 5177.948220517746, 4788.0, 4812.807487700453, 4848.32123502717, 4884.8290309838985, 4886.438059623189, 5018.322526458881, 5021.974890125673, 5067.569256613082, 5100.107481190703, 5139.588832893285, 4981.3026176334615, 5031.572316353005, 5193.61047921415, 5204.713740744144, 5204.947950520446, 4917.213245880642, 4961.776720047678, 4983.0, 4987.276844857548, 5025.271335656383, 4947.925781113358, 4973.254011898244, 4981.227909674007, 4993.875153121201, 5046.520580544842, 4773.212419950669, 4886.071646387175, 4906.607471402351, 4949.455559888482, 4954.0, 5079.136546787129, 5098.770555324945, 5108.28484012246, 5111.795528178831, 5138.383393992595, 4982.701037937735, 5001.724905130252, 5002.774875130555, 5002.949970500394, 5051.141305977919], "value": 4691.880959624025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.6568891509552, 583.6731430398975, 589.6167491130761, 592.6947621974684, 593.1488314269025, 27817.721822781765, 40341.0, 41487.0, 41602.37596436052, 44491.77754111233, 40458.0, 40929.386059209064, 40931.0, 40955.79522102393, 41081.38377924333, 7426.62866856655, 7913.762587122395, 8054.194580541928, 8062.596870156469, 8070.0, 7407.666655000511, 7642.426817988645, 7649.885251721229, 10016.54925528353, 10379.89620103797, 10488.318259313159, 10518.263721539495, 10526.631567895087, 10538.0, 10546.736331591695, 10263.589456421734, 10289.588416463332, 10353.378797272188, 10360.378377297386, 10365.118964888032, 7508.662110205054, 7718.922810771876, 7730.7680769577, 9850.359726617748, 10259.17926565873, 39089.41365879514, 39400.802995984835, 39439.211215775525, 39486.40770388446, 39509.20981580352, 3113.252819323369, 3323.601167859848, 3354.8658053677823, 3384.8307584620916, 3502.94911526541, 29264.0, 29278.414431711248, 29709.635436145392, 30049.248768780737, 31245.843770781226, 3304.206990322329, 3443.5523381960434, 3448.2241495663525, 3450.706689931359, 3487.1979444727854, 254247.0, 254398.0, 254787.0, 255148.0, 257661.0, 53063.46936530585, 53711.73144134254, 53835.0, 53846.46153538493, 53866.0, 57674.0, 57771.422285777444, 57783.13325300124, 57880.0, 57897.13154302689, 14273.857261427253, 14675.412983480755, 14700.852991470163, 14717.411303547953, 14747.262636868114, 10420.114290285259, 11368.261063030877, 11409.771804564029, 11460.369679667698, 11460.426978651034, 15903.761443578356, 16438.835611643968, 16458.506244812674, 16706.0, 16745.33018679239, 5520.613557051048, 5534.086875665551, 5551.833444996657, 5584.190292407578, 5619.887602247933, 809.3969992355615, 828.8632375658069, 908.1644886704248, 922.754281719673, 932.7201839448275, 28475.0, 28626.856865715956, 28710.425791484053, 28767.56848647272, 29175.562366564518, 928.5310917986374, 942.2838642631649, 965.4207475514635, 978.500964508106, 1032.4166845732288, 15678.0, 16360.509184724477, 16391.344346226255, 17039.48881533556, 17298.65402691939, 393889.0, 394779.0, 396169.0, 396725.0, 397272.0, 49271.0, 49348.75325623349, 49443.258351124765, 49505.0, 49560.50439495559, 1081.6754973507916, 1110.2062025651699, 1168.5851522709315, 1217.0811037666683, 1223.0460241012024, 27177.320566985192, 28695.569566456936, 29116.7088329114, 29479.26301842385, 29681.25796855096, 41903.58096419119, 42248.78875605603, 42361.57638423576, 42369.78815106028, 42428.57571424246, 307473.0, 307546.0, 308025.0, 308911.0, 309133.0, 23812.0, 24473.143439979514, 25129.497410052063, 25527.234182974542, 25554.23337299884, 41368.37947430851, 41659.58340416557, 41977.0, 42180.78909605432, 42875.14249714926, 34534.30931381308, 35345.469817953264, 36174.27651447009, 36297.0, 36365.45451818278, 35987.280254395286, 36121.63878361288, 36234.27531449409, 36683.44974825433, 37020.0, 35193.82403087968, 35327.646723533464, 37186.62813371832, 38055.238895222494, 38101.0, 31429.799914005802, 33818.66181338155, 33824.49263261004, 33854.661453386136, 34052.65947340495, 25689.0, 27300.31749206286, 27633.447331053667, 27816.582751259153, 27911.0], "value": 17991.292237665908, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.52717993788013, 368.44365008836667, 372.16263407333497, 386.47439482304077, 386.5747677554688, 16422.26099825508, 17037.0, 17732.64534709305, 17752.378666746667, 17752.64494710105, 15962.600934976632, 16988.32046718133, 17321.566960825985, 17694.82305176948, 17717.1141442928, 4659.813607455706, 4851.029794041188, 4881.8535443936735, 4882.829100981467, 4886.096072226632, 3523.260115375774, 3688.299223147607, 4774.641901857357, 5748.45389687979, 6061.151438798572, 6090.0, 6099.390060993909, 6122.938770612282, 6140.877182456348, 6141.385861413867, 5416.972915135439, 5476.3702174250075, 5477.780888764464, 5480.26016487773, 5558.305211848519, 3410.18155642644, 5084.898302033976, 5288.048151332759, 5352.91970620441, 5364.329458817648, 12772.936135319356, 12783.872161278361, 12894.032947528973, 15325.616859578487, 21474.463138421663, 1821.6083542038525, 1853.7590113285187, 1856.2760523395887, 1938.8545859060628, 2032.7459067616549, 9669.419834809934, 9743.610255589769, 13214.801777973338, 13601.523946661819, 13858.792118118236, 1771.0878897367866, 1788.5081602559271, 1821.8087100854484, 1840.935567255153, 1849.843847595253, 68367.31632683708, 70020.53285506608, 70932.2906770936, 71983.64008179978, 72922.63538682325, 10063.194944404577, 10196.3372380795, 10220.744481388025, 10255.94872025635, 10556.0, 14018.228997405036, 14127.293635318192, 14132.0, 14145.787813182811, 14173.645658858612, 7270.935175874369, 7512.737054203077, 7523.473356865076, 7690.0, 7772.261635144652, 6856.0, 7108.0, 7196.698488464661, 7213.098362704662, 7273.381762550137, 4313.352997050468, 4423.8009289581405, 4440.666949978765, 4505.842295519641, 4519.909601807945, 1633.8039435267606, 1734.8612111031086, 1763.5943732941496, 1820.5642359387898, 1851.6389304085844, 763.2939530933864, 831.2103501673434, 862.5945805471418, 880.5245167609547, 967.8935317115112, 16889.071101089557, 17076.658466830842, 17177.828221717624, 17344.306227751, 17724.468265951786, 844.0757370679097, 860.7589874835056, 872.1017352127319, 882.580774132282, 902.747230775384, 9577.760555986157, 9670.70987870365, 9734.172595329477, 9738.90261097394, 9910.0, 369646.8565029582, 376077.0, 377664.0, 400166.0, 402534.0, 74710.62644686742, 76577.61711191408, 76869.0, 77355.61322193353, 77394.2260577387, 900.8513595256709, 908.2189317187214, 909.9818003640023, 923.6582464488182, 924.9075092490697, 15513.224338783242, 15571.610709732347, 15819.920900395424, 15887.602809929844, 16157.353705851634, 38585.0, 38980.80509597434, 39105.6089439102, 39693.2061358777, 39792.20415591614, 52373.21440178324, 53119.468805313, 53737.46262537324, 53797.73101134626, 53802.461975379745, 7773.650185741768, 7779.027621547307, 7824.295813376823, 8013.919860801318, 8014.358851292, 11230.0, 12390.62828115158, 12444.502219911103, 12528.0, 12589.0, 10353.482325883526, 10429.16566674649, 10442.216833737652, 10565.788684226118, 10609.8939010612, 10420.947895260475, 10500.79968012801, 10580.100691441314, 10699.839502407314, 10871.891281087088, 10139.0, 10610.257281990187, 10639.787204255717, 10703.518341674799, 10920.726981825517, 7768.689252429839, 7778.533288002738, 7882.802929926797, 7951.761447156595, 7984.321332686786, 7770.067591889009, 9081.545922703706, 10241.0, 10402.323848949794, 10416.32293900894], "value": 8276.64844076069, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.3548799808086, 1403.3474434388008, 1508.7661412481064, 1683.5791052236941, 1707.044055329016, 7543.849123017536, 8022.799430014238, 8122.593870306483, 8135.349172066235, 8140.552269625168, 6810.216825065119, 7483.962580187105, 7752.573608451533, 7753.263439973208, 7969.561674107937, 2192.7916847899505, 2229.320057382498, 2231.4086767006756, 2232.4195709115666, 2232.520008198237, 1910.732497450358, 2125.1818050050765, 2162.081115525903, 2184.126349460221, 2235.474663454087, 2192.561487702466, 2235.564065007324, 2236.83223758218, 2237.2617036377956, 2239.3393948785147, 2174.63031284682, 2187.387531491185, 2204.250554811356, 2206.801387875083, 2207.84088353614, 2177.7277840269967, 2192.0574153114153, 2197.681336206241, 2200.9119635214574, 2203.9779602203935, 8024.317932975704, 8064.0, 8092.716754913608, 8093.716719914774, 8110.459012787552, 4502.189605870942, 4526.954730452686, 4664.743439110847, 4665.4168228971375, 4675.18184317743, 2907.9273018174504, 2991.6110905582136, 3030.0606811888383, 3038.1189455058006, 3070.570120183176, 968.6997030920437, 983.1446641421937, 996.496769131584, 1015.6546774096843, 1015.939043657383, 10891.07425868802, 10904.400257985808, 10914.399708016055, 10934.45327733618, 10967.83548246777, 4127.463429754112, 4154.376843473443, 4321.243782338078, 4321.654267658642, 4377.277749171351, 9274.397164184307, 9275.118863707938, 9296.209822165192, 9308.255339572817, 9308.627654893728, 4688.742119183477, 4694.460137084211, 4704.764761761899, 4711.882202944954, 4714.033623107255, 4211.915761684749, 4256.084941737541, 4257.8509752158525, 4258.723182993095, 4262.850800221977, 3708.072981754561, 3754.1365485938386, 3786.3184626766897, 3809.12390150267, 3838.1364193056897, 1106.878243393226, 1167.1538134852333, 1224.8775122487857, 1231.6736064942797, 1238.795598726218, 620.5159975219336, 746.8468963862396, 752.9322360987428, 779.2558107007794, 785.3442375616424, 4926.211806111005, 4996.350474438373, 5096.464871188546, 5112.616553758483, 5236.450172731808, 800.1718221640574, 806.9878951815728, 850.9872351914727, 859.1022381611232, 865.2774932930947, 3395.813230272359, 3482.59950105736, 3514.63096374877, 3529.4529347951107, 3569.5894972078545, 9074.818503630022, 9345.859812102824, 9401.717948461557, 9421.481818500048, 9450.716478505656, 8708.43395179324, 9094.0, 9338.393004454689, 9348.392354497071, 9528.380655257386, 7375.336219740249, 7476.364509016686, 7535.962320188364, 7538.170801211862, 7544.735934242385, 5195.636305458582, 5299.099153144052, 5393.568514518751, 5421.024215641065, 5443.59173062014, 8886.289096872106, 9190.770230744285, 9245.19718654856, 9264.39781414206, 9272.397294175857, 8714.085021072697, 9136.26909847224, 9248.398854074463, 9249.861252081359, 9289.396189247676, 6840.110785597841, 6947.79156625302, 6976.0, 6987.615681137383, 6995.300469952964, 7488.326050655467, 7548.4716069874585, 7574.091109066947, 7584.355329797029, 7588.165301816685, 6389.9680501597195, 6410.935890641221, 6707.966460167668, 6881.759138430331, 6886.48351373659, 6808.353206445379, 6841.863162736817, 6901.033855260167, 7023.859522809617, 7052.18899826506, 5711.228984087095, 5748.741306641295, 5751.568632352507, 5758.3090029196765, 5765.798197063083, 4086.7547947123267, 4200.81096350671, 4315.266404711144, 4340.305551111933, 4409.3606427068535, 4297.162053399682, 4385.912281754411, 4406.2068827610055, 4457.8439754608435, 4497.145542346943], "value": 4144.7301695518345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.44391215174335, 292.2576655295549, 293.8824470211914, 296.6425457323925, 299.7871511227029, 4819.518048195178, 4858.0, 4871.391076115486, 4891.951080489194, 4941.283513890493, 4819.734914579697, 4844.636652251078, 4844.781984810683, 4855.417349918006, 4872.658913876021, 3653.4885116083838, 3725.16183858631, 3756.4177552479273, 3819.197968426634, 3847.230553889219, 3805.448210009547, 3807.6953843692577, 3823.655870971612, 3835.884923452287, 3843.5195600549932, 3608.0, 3789.109559253573, 3790.6777923876502, 3792.563855156665, 3794.203217324365, 3658.3414985302634, 3757.830897609587, 3763.473113764089, 3797.6582107610448, 3807.866724664651, 3370.5281260623533, 3372.3086767212662, 3376.74674399421, 3380.6619338066, 3404.8297585120645, 4719.905601887977, 4720.881977950545, 4724.881877953045, 4736.668433209677, 4741.596964258042, 4242.0, 4338.544452832439, 4360.760158191299, 4369.6185578859595, 4371.78141092944, 4935.9753201234125, 4993.850184494471, 5003.74981250936, 5033.421156567005, 5040.16837221858, 3670.6418625108613, 3671.614480479538, 3672.540932383452, 3682.8895133146048, 3691.151035261905, 5110.259012443212, 5245.895082098336, 5259.053370393328, 5259.737013149365, 5260.0, 3753.418220175877, 3761.3981762918347, 3765.435184722259, 3766.7363284569815, 3775.981120094382, 3799.903078990669, 3810.809459527068, 3811.904702382463, 3826.100866296418, 3827.5024246847734, 4262.893427664333, 4311.568843115726, 4312.611864932172, 4327.480702315742, 4354.0, 4873.829415970424, 5032.773525191302, 5037.0, 5043.193089105725, 5046.697198168122, 1303.5307289375817, 1315.6184706435217, 1325.9602211933657, 1327.99736199169, 1330.1487048289102, 837.7905523619095, 843.3927572148043, 850.37497439382, 891.8528442806864, 916.5508900638772, 4378.408914796461, 4395.494518130392, 4396.230659634552, 4399.846005389796, 4402.163588918095, 5095.414027386898, 5119.539241468286, 5122.103631864484, 5127.692338459704, 5137.33214682089, 4240.936385954213, 4365.410669559569, 4370.934435983463, 4375.912481750347, 4378.5183629800695, 2751.2021513760783, 2761.2130542795207, 2772.1031522059498, 2774.750272475487, 2781.235160330885, 4881.95118048822, 4889.951100489021, 4893.070316639827, 4899.113841171104, 4922.606191504671, 5106.897862042739, 5304.09052741013, 5306.442823503477, 5363.249145119687, 5382.892342153135, 4924.4090709115135, 4940.654154209171, 4950.925736113889, 4951.950480495221, 4963.90072198554, 5164.586833053271, 5227.529522343008, 5240.554552862897, 5251.343582052244, 5255.737213139251, 4896.0, 5174.818881339135, 5186.0, 5202.063628546746, 5203.297554830049, 4930.6795058321095, 4947.208446648519, 4949.480304567968, 4951.9257211142585, 4961.925571116509, 3672.485851980671, 3685.115572262584, 3693.6306369362846, 3693.796841173761, 3708.147126161052, 5100.897982040413, 5200.323957885451, 5215.504527069922, 5300.893982120258, 5327.467253274642, 5012.699238045583, 5039.5968322534845, 5041.7647676318065, 5055.873603159804, 5060.3927528696795, 5043.646944713835, 5070.645054846125, 5118.641695081308, 5119.667221630582, 5131.461196574306, 4777.402824646919, 5034.0686972910125, 5051.4695956924, 5059.974700126476, 5096.898062038665, 4869.735572958592, 4981.726005069756, 5165.579465646827, 5173.896522069613, 5185.481451854785, 4998.0, 5005.174146265971, 5015.699058056528, 5023.8696293333705, 5092.770825312944], "value": 3828.6228055437587, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.2015001772846, 694.5728377048114, 733.0836454431957, 742.283696233135, 764.6313099551804, 11947.7610447791, 12281.692957676063, 12996.935015324934, 13053.086283960127, 14948.626284342898, 14276.4289428423, 14432.711345773077, 14439.63900902478, 14458.060226085323, 14500.057496262736, 769.4613770360755, 786.2334224131483, 787.1695361393728, 790.9050913890312, 791.7703865878888, 627.8147946355836, 749.1085608126313, 783.0955246690054, 787.2953706432739, 787.9527228366317, 842.4692443760422, 845.049319515545, 848.5714714069386, 848.6902280667542, 849.2993280543545, 833.6123702478316, 834.3492076180589, 834.4159088637947, 834.4284165346696, 834.6369329341755, 612.6232367094206, 612.7855250662277, 612.791650838717, 613.5275837605019, 613.9969300153515, 11116.444177791078, 11254.099672026217, 11276.43617819114, 11277.54889804415, 11301.095912326995, 13176.868231317756, 13442.731145377136, 13529.729405411936, 13566.728665426635, 13717.245551494663, 10216.798391431634, 10323.277370584063, 10533.104686101691, 10634.62778802746, 10652.573897044109, 3372.932541349184, 3392.0502259367418, 3406.7615266931325, 3461.463473161664, 3513.2797776455764, 60602.696986514784, 60940.0, 61179.694101529654, 62480.0, 62734.372656273765, 9647.421154730739, 9912.851307230398, 10057.396556206651, 10279.537420816081, 10468.63359782404, 20208.29270975509, 20269.391918242476, 20304.08631611581, 20306.492337691678, 20757.377278681663, 6907.723691052302, 6930.3762661360715, 6944.7222111116, 7040.295970402919, 7112.324329188718, 3761.4733937248807, 3844.5386553613744, 3856.151646637791, 3888.4556162137324, 3888.949983504438, 2883.3656595548946, 2979.731824135838, 2979.851007449619, 2979.955300670492, 2984.373281610886, 499.8300577803564, 510.2524801166309, 511.5728366813678, 515.3120584020375, 520.8775937654648, 463.7542102685582, 586.8122200895758, 621.6554934452616, 634.0362648773838, 641.7785863876956, 8183.795405114801, 8345.874811877828, 8550.700725474579, 8571.357148213909, 8660.13398660129, 490.029741112599, 506.7770181120295, 614.2935624032399, 616.1866336435861, 623.9875202495924, 3868.8065596720053, 4082.857100001486, 4106.589341065869, 4126.298529249974, 4240.38514415408, 59533.10700339499, 90879.54560227289, 93350.0, 93421.53289233646, 93685.0, 49092.52722418333, 49260.26109608359, 49310.75344623254, 50079.0, 50394.0, 59287.071292870365, 72967.0, 73020.63489682517, 73244.26755732375, 75867.62066189744, 7718.3053525183, 7727.536347819148, 7772.183920688246, 7795.473595976566, 8076.676932922617, 29893.551596725632, 30559.847200763856, 30717.078487645405, 31208.843955780078, 31326.216844579067, 57641.42358576361, 64264.0, 64331.67834160799, 65726.34273657203, 65779.0, 10289.228307876789, 10926.125909927347, 11317.886821131684, 11403.942980285046, 11883.0, 12447.93776031114, 13200.075994680281, 13209.405576749261, 13694.041417101105, 14226.35981380861, 12063.577774777841, 12244.081693872817, 12693.555725549562, 12996.155249908727, 13534.79697804514, 11631.59289424866, 11658.825117623073, 11837.526498939946, 12499.625011249676, 12832.55086071983, 12438.685152278626, 12561.623151305475, 12678.746425071631, 12960.481580736665, 13271.800922986356, 9356.766080848034, 9531.809363812823, 9753.951230243803, 9908.306418550632, 10016.0, 9486.573104210465, 9827.869794973669, 9850.408975461496, 9866.901330986599, 9888.85166722514], "value": 6457.942628445278, "unit": "score"}], "name": "dromaeo_css", "value": 6444.034482602014, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 115.0, 113.0, 114.0, 114.0, 115.0, 113.0, 114.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 129.0, 129.0, 183.0, 122.0, 126.0, 156.0, 127.0, 172.0, 126.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 161.0, 163.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 129.0, 76.0, 76.0, 76.0, 75.0, 104.0, 76.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 120.0, 85.0, 85.0, 85.0, 125.0, 86.0, 85.0, 119.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 65.0, 64.0, 63.0, 64.0, 65.0, 63.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 67.0, 66.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 85.0, 78.0, 78.0, 79.0, 78.0, 79.0, 79.0, 81.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 128.0, 129.0, 128.0, 127.0, 128.0, 128.0, 209.0, 140.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 166.0, 165.0, 163.0, 165.0, 165.0, 163.0, 165.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 71.0, 66.0, 66.0, 67.0, 67.0, 67.0, 65.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1534.4, "alertThreshold": 2.0}]} 04:04:10 INFO - Return code: 0 04:04:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:04:10 INFO - # TBPL SUCCESS # 04:04:10 INFO - Running post-action listener: _resource_record_post_action 04:04:10 INFO - ##### 04:04:10 INFO - ##### Finished run-tests step (success) 04:04:10 INFO - ##### 04:04:10 INFO - Running post-run listener: _resource_record_post_run 04:04:10 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 541171712; Read time: 0; Write time: 1108016 04:04:10 INFO - TinderboxPrint: CPU usage
13.0% 04:04:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:04:10 INFO - TinderboxPrint: I/O write bytes / time
541,171,712 / 1,108,016 04:04:10 INFO - TinderboxPrint: CPU idle
8,328.6 (86.9%) 04:04:10 INFO - TinderboxPrint: CPU user
1,198.0 (12.5%) 04:04:10 INFO - TinderboxPrint: Swap in / out
0 / 0 04:04:10 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 245575680; Read time: 0; Write time: 656628 04:04:10 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 295596032; Read time: 0; Write time: 451388 04:04:11 INFO - Running post-run listener: _upload_blobber_files 04:04:11 INFO - Blob upload gear active. 04:04:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:04:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:04:11 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:04:11 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:04:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:04:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:04:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:04:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:15 INFO - (blobuploader) - INFO - Done attempting. 04:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:16 INFO - (blobuploader) - INFO - Done attempting. 04:04:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:04:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:16 INFO - (blobuploader) - INFO - Done attempting. 04:04:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:04:16 INFO - Return code: 0 04:04:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:04:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:04:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4433a951633193a48c21d58b9f714d421b1a9dfda05219c1397a2c20a14f30538310c6719138d0d796c9a8ec7da7c321dde3782b5d6e470c6f89897481929839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86c635b40ef304c91492e98c13f5263d47bef1768b35080f914633a7982213340a78fe377f32ffa4c541bfbeb41c25fdb9c056673d4d18dfd1a0a63895502eb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2750d4719d60a12dc4b69620b16a82df07ebd1e04da1db38d58cc2e83ef7106432bff4a5b543b94c056935d80621cfc4974f2e89122f0b98d1404f41ce5032ba"} 04:04:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:04:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:04:16 INFO - Contents: 04:04:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4433a951633193a48c21d58b9f714d421b1a9dfda05219c1397a2c20a14f30538310c6719138d0d796c9a8ec7da7c321dde3782b5d6e470c6f89897481929839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86c635b40ef304c91492e98c13f5263d47bef1768b35080f914633a7982213340a78fe377f32ffa4c541bfbeb41c25fdb9c056673d4d18dfd1a0a63895502eb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2750d4719d60a12dc4b69620b16a82df07ebd1e04da1db38d58cc2e83ef7106432bff4a5b543b94c056935d80621cfc4974f2e89122f0b98d1404f41ce5032ba"} 04:04:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:04:16 INFO - Copying logs to upload dir... 04:04:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:04:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.059784 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-01 04:04:16.249841) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 04:04:16.253671) ========= 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=745a4373a2a16df560f216e000000264-1467369815.289176-1036070337 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-Non-PGO/sha512/4433a951633193a48c21d58b9f714d421b1a9dfda05219c1397a2c20a14f30538310c6719138d0d796c9a8ec7da7c321dde3782b5d6e470c6f89897481929839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86c635b40ef304c91492e98c13f5263d47bef1768b35080f914633a7982213340a78fe377f32ffa4c541bfbeb41c25fdb9c056673d4d18dfd1a0a63895502eb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2750d4719d60a12dc4b69620b16a82df07ebd1e04da1db38d58cc2e83ef7106432bff4a5b543b94c056935d80621cfc4974f2e89122f0b98d1404f41ce5032ba"} build_url:https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/Ckkfhnz4T923IhmH-UxOqA/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-Non-PGO/sha512/4433a951633193a48c21d58b9f714d421b1a9dfda05219c1397a2c20a14f30538310c6719138d0d796c9a8ec7da7c321dde3782b5d6e470c6f89897481929839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86c635b40ef304c91492e98c13f5263d47bef1768b35080f914633a7982213340a78fe377f32ffa4c541bfbeb41c25fdb9c056673d4d18dfd1a0a63895502eb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2750d4719d60a12dc4b69620b16a82df07ebd1e04da1db38d58cc2e83ef7106432bff4a5b543b94c056935d80621cfc4974f2e89122f0b98d1404f41ce5032ba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 04:04:16.281490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 04:04:16.281944) ========= 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=745a4373a2a16df560f216e000000264-1467369815.289176-1036070337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 04:04:16.369462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 04:04:16.370274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 04:04:16.370987) ========= ========= Total master_lag: 0.19 =========