builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1467186553.2 results: success (0) buildid: 20160628071022 builduid: 17a19734969742aa8e8d11147118e308 revision: e45890951ce77c3df05575bd54072b9f300d77b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:13.197063) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:13.197637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:13.197983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:13.216573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:13.217271) ========= 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=6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 00:49:13-- 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% 223M=0s 2016-06-29 00:49:13 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083828 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:13.339052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:13.340066) ========= 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=6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018021 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:13.431292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:13.431668) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e45890951ce77c3df05575bd54072b9f300d77b0 --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 e45890951ce77c3df05575bd54072b9f300d77b0 --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=6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 00:49:13,712 truncating revision to first 12 chars 2016-06-29 00:49:13,712 Setting DEBUG logging. 2016-06-29 00:49:13,712 attempt 1/10 2016-06-29 00:49:13,712 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e45890951ce7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 00:49:14,051 unpacking tar archive at: mozilla-central-e45890951ce7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725341 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:14.202650) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:14.203092) ========= script_repo_revision: e45890951ce77c3df05575bd54072b9f300d77b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:14.203611) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:14.203928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:14.217733) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-29 00:49:14.218387) ========= /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=6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:49:14 INFO - MultiFileLogger online at 20160629 00:49:14 in /builds/slave/test 00:49:14 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 00:49:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:49:14 INFO - {'append_to_log': False, 00:49:14 INFO - 'base_work_dir': '/builds/slave/test', 00:49:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 00:49:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:49:14 INFO - 'branch': 'Firefox-Non-PGO', 00:49:14 INFO - 'buildbot_json_path': 'buildprops.json', 00:49:14 INFO - 'config_files': ('talos/linux_config.py',), 00:49:14 INFO - 'default_actions': ('clobber', 00:49:14 INFO - 'read-buildbot-config', 00:49:14 INFO - 'download-and-extract', 00:49:14 INFO - 'populate-webroot', 00:49:14 INFO - 'create-virtualenv', 00:49:14 INFO - 'install', 00:49:14 INFO - 'run-tests'), 00:49:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:49:14 INFO - 'download_minidump_stackwalk': True, 00:49:14 INFO - 'download_symbols': 'ondemand', 00:49:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:49:14 INFO - 'tooltool.py': '/tools/tooltool.py', 00:49:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:49:14 INFO - '/tools/misc-python/virtualenv.py')}, 00:49:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:49:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:49:14 INFO - 'installer_path': 'installer.exe', 00:49:14 INFO - 'log_level': 'info', 00:49:14 INFO - 'log_name': 'talos', 00:49:14 INFO - 'log_to_console': True, 00:49:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:49:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:49:14 INFO - 'opt_config_files': (), 00:49:14 INFO - 'pip_index': False, 00:49:14 INFO - 'sps_profile': False, 00:49:14 INFO - 'sps_profile_interval': 0, 00:49:14 INFO - 'suite': 'dromaeojs', 00:49:14 INFO - 'system_bits': '32', 00:49:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:49:14 INFO - 'title': 'talos-linux64-ix-050', 00:49:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:49:14 INFO - 'use_talos_json': True, 00:49:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:49:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:49:14 INFO - 'work_dir': 'build'} 00:49:14 INFO - ##### 00:49:14 INFO - ##### Running clobber step. 00:49:14 INFO - ##### 00:49:14 INFO - Running pre-action listener: _resource_record_pre_action 00:49:14 INFO - Running main action method: clobber 00:49:14 INFO - rmtree: /builds/slave/test/build 00:49:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:49:15 INFO - Running post-action listener: _resource_record_post_action 00:49:15 INFO - ##### 00:49:15 INFO - ##### Finished clobber step (success) 00:49:15 INFO - ##### 00:49:15 INFO - ##### 00:49:15 INFO - ##### Running read-buildbot-config step. 00:49:15 INFO - ##### 00:49:15 INFO - Running pre-action listener: _resource_record_pre_action 00:49:15 INFO - Running main action method: read_buildbot_config 00:49:15 INFO - Using buildbot properties: 00:49:15 INFO - { 00:49:15 INFO - "project": "", 00:49:15 INFO - "product": "firefox", 00:49:15 INFO - "script_repo_revision": "production", 00:49:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 00:49:15 INFO - "repository": "", 00:49:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 00:49:15 INFO - "buildid": "20160628071022", 00:49:15 INFO - "pgo_build": "False", 00:49:15 INFO - "basedir": "/builds/slave/test", 00:49:15 INFO - "buildnumber": 536, 00:49:15 INFO - "slavename": "talos-linux64-ix-050", 00:49:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:49:15 INFO - "platform": "ubuntu64_hw", 00:49:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 00:49:15 INFO - "branch": "mozilla-central", 00:49:15 INFO - "repo_path": "mozilla-central", 00:49:15 INFO - "revision": "e45890951ce77c3df05575bd54072b9f300d77b0", 00:49:15 INFO - "stage_platform": "linux64", 00:49:15 INFO - "builduid": "17a19734969742aa8e8d11147118e308", 00:49:15 INFO - "slavebuilddir": "test" 00:49:15 INFO - } 00:49:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:49:15 INFO - Running post-action listener: _resource_record_post_action 00:49:15 INFO - ##### 00:49:15 INFO - ##### Finished read-buildbot-config step (success) 00:49:15 INFO - ##### 00:49:15 INFO - ##### 00:49:15 INFO - ##### Running download-and-extract step. 00:49:15 INFO - ##### 00:49:15 INFO - Running pre-action listener: _resource_record_pre_action 00:49:15 INFO - Running main action method: download_and_extract 00:49:15 INFO - mkdir: /builds/slave/test/build/tests 00:49:15 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')]} 00:49:15 INFO - https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:49:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:49:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:49:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:15 INFO - Downloaded 1361 bytes. 00:49:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:49:15 INFO - Using the following test package requirements: 00:49:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:49:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:49:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:15 INFO - u'jsshell-linux-x86_64.zip'], 00:49:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:49:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:49:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:49:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:49:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:49:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:49:15 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')]} 00:49:15 INFO - https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:49:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:49:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:49:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:18 INFO - Downloaded 22700070 bytes. 00:49:18 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'] 00:49:18 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 00:49:19 INFO - Return code: 0 00:49:19 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 00:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:19 INFO - https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:24 INFO - Downloaded 22700070 bytes. 00:49:24 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'] 00:49:24 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 00:49:25 INFO - Return code: 0 00:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:25 INFO - https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:27 INFO - Downloaded 14405245 bytes. 00:49:27 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'] 00:49:27 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 00:49:27 INFO - Return code: 0 00:49:27 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')]} 00:49:27 INFO - https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:37 INFO - Downloaded 56431652 bytes. 00:49:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:49:37 INFO - mkdir: /builds/slave/test/properties 00:49:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:49:37 INFO - Writing to file /builds/slave/test/properties/build_url 00:49:37 INFO - Contents: 00:49:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:49:38 INFO - Running post-action listener: _resource_record_post_action 00:49:38 INFO - Running post-action listener: set_extra_try_arguments 00:49:38 INFO - ##### 00:49:38 INFO - ##### Finished download-and-extract step (success) 00:49:38 INFO - ##### 00:49:38 INFO - ##### 00:49:38 INFO - ##### Running populate-webroot step. 00:49:38 INFO - ##### 00:49:38 INFO - Running pre-action listener: _resource_record_pre_action 00:49:38 INFO - Running main action method: populate_webroot 00:49:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:49:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:49:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:49:38 INFO - '--tppagecycles', 00:49:38 INFO - '7'], 00:49:38 INFO - 'tests': ['tsvgm']}}, 00:49:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:49:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:49:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:49:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:49:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:38 INFO - 'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:38 INFO - 'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['damp', 'tps']}, 00:49:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:38 INFO - 'tests': ['damp', 'tps']}, 00:49:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['dromaeo_dom']}, 00:49:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:49:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['basic_compositor_video']}, 00:49:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:49:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['a11yr', 00:49:38 INFO - 'ts_paint', 00:49:38 INFO - 'tpaint', 00:49:38 INFO - 'sessionrestore', 00:49:38 INFO - 'sessionrestore_no_auto_restore', 00:49:38 INFO - 'tabpaint']}, 00:49:38 INFO - 'other-e10s': {'tests': ['a11yr', 00:49:38 INFO - 'ts_paint', 00:49:38 INFO - 'tpaint', 00:49:38 INFO - 'sessionrestore', 00:49:38 INFO - 'sessionrestore_no_auto_restore', 00:49:38 INFO - 'tabpaint']}, 00:49:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:49:38 INFO - 'ts_paint', 00:49:38 INFO - 'tpaint', 00:49:38 INFO - 'sessionrestore', 00:49:38 INFO - 'sessionrestore_no_auto_restore', 00:49:38 INFO - 'tabpaint']}, 00:49:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:49:38 INFO - 'ts_paint', 00:49:38 INFO - 'tpaint', 00:49:38 INFO - 'sessionrestore', 00:49:38 INFO - 'sessionrestore_no_auto_restore', 00:49:38 INFO - 'tabpaint']}, 00:49:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['a11yr', 00:49:38 INFO - 'ts_paint', 00:49:38 INFO - 'tpaint', 00:49:38 INFO - 'sessionrestore', 00:49:38 INFO - 'sessionrestore_no_auto_restore', 00:49:38 INFO - 'tabpaint']}, 00:49:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['a11yr', 00:49:38 INFO - 'ts_paint', 00:49:38 INFO - 'tpaint', 00:49:38 INFO - 'sessionrestore', 00:49:38 INFO - 'sessionrestore_no_auto_restore', 00:49:38 INFO - 'tabpaint']}, 00:49:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['tsvgx', 00:49:38 INFO - 'tsvgr_opacity', 00:49:38 INFO - 'tart', 00:49:38 INFO - 'tscrollx', 00:49:38 INFO - 'cart']}, 00:49:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:49:38 INFO - 'tsvgr_opacity', 00:49:38 INFO - 'tart', 00:49:38 INFO - 'tscrollx', 00:49:38 INFO - 'cart']}, 00:49:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:38 INFO - 'talos_options': ['--disable-e10s'], 00:49:38 INFO - 'tests': ['tp5o']}, 00:49:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:38 INFO - 'tests': ['tp5o']}, 00:49:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:38 INFO - 'talos_options': ['--disable-e10s', 00:49:38 INFO - '--xperf_path', 00:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:38 INFO - 'tests': ['tp5n']}, 00:49:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:38 INFO - 'talos_options': ['--xperf_path', 00:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:38 INFO - 'tests': ['tp5n']}}, 00:49:38 INFO - 'talos.zip': {'path': '', 00:49:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:49:38 INFO - Running post-action listener: _resource_record_post_action 00:49:38 INFO - ##### 00:49:38 INFO - ##### Finished populate-webroot step (success) 00:49:38 INFO - ##### 00:49:38 INFO - ##### 00:49:38 INFO - ##### Running create-virtualenv step. 00:49:38 INFO - ##### 00:49:38 INFO - Running pre-action listener: _resource_record_pre_action 00:49:38 INFO - Running main action method: create_virtualenv 00:49:38 INFO - Creating virtualenv /builds/slave/test/build/venv 00:49:38 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 00:49:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:49:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:49:38 INFO - Using real prefix '/usr' 00:49:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:49:39 INFO - Installing distribute.............................................................................................................................................................................................done. 00:49:41 INFO - Installing pip.................done. 00:49:41 INFO - Return code: 0 00:49:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:41 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 0xe64030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11233b0>, '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 0x11242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124740>, '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': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', '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 00:49:41 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 00:49:41 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 00:49:41 INFO - Using env: {'DISPLAY': ':0', 00:49:41 INFO - 'HOME': '/home/cltbld', 00:49:41 INFO - 'LANG': 'en_US.UTF-8', 00:49:41 INFO - 'LANGUAGE': 'en_US:en', 00:49:41 INFO - 'LOGNAME': 'cltbld', 00:49:41 INFO - 'MAIL': '/var/mail/cltbld', 00:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:41 INFO - 'MOZ_NO_REMOTE': '1', 00:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:41 INFO - 'NO_EM_RESTART': '1', 00:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:41 INFO - 'PWD': '/builds/slave/test', 00:49:41 INFO - 'SHELL': '/bin/bash', 00:49:41 INFO - 'SHLVL': '1', 00:49:41 INFO - 'TERM': 'linux', 00:49:41 INFO - 'TMOUT': '86400', 00:49:41 INFO - 'USER': 'cltbld', 00:49:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', 00:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:41 INFO - '_': '/tools/buildbot/bin/python'} 00:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:41 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 00:49:41 INFO - Cleaning up... 00:49:41 INFO - Return code: 0 00:49:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:41 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 0xe64030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11233b0>, '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 0x11242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124740>, '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': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', '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 00:49:41 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 00:49:41 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 00:49:41 INFO - Using env: {'DISPLAY': ':0', 00:49:41 INFO - 'HOME': '/home/cltbld', 00:49:41 INFO - 'LANG': 'en_US.UTF-8', 00:49:41 INFO - 'LANGUAGE': 'en_US:en', 00:49:41 INFO - 'LOGNAME': 'cltbld', 00:49:41 INFO - 'MAIL': '/var/mail/cltbld', 00:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:41 INFO - 'MOZ_NO_REMOTE': '1', 00:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:41 INFO - 'NO_EM_RESTART': '1', 00:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:41 INFO - 'PWD': '/builds/slave/test', 00:49:41 INFO - 'SHELL': '/bin/bash', 00:49:41 INFO - 'SHLVL': '1', 00:49:41 INFO - 'TERM': 'linux', 00:49:41 INFO - 'TMOUT': '86400', 00:49:41 INFO - 'USER': 'cltbld', 00:49:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', 00:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:41 INFO - '_': '/tools/buildbot/bin/python'} 00:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:41 INFO - Downloading/unpacking psutil>=3.1.1 00:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:49:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:43 INFO - Installing collected packages: psutil 00:49:43 INFO - Running setup.py install for psutil 00:49:43 INFO - building 'psutil._psutil_linux' extension 00:49:43 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 00:49:43 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 00:49:43 INFO - building 'psutil._psutil_posix' extension 00:49:43 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 00:49:43 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 00:49:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:43 INFO - Successfully installed psutil 00:49:43 INFO - Cleaning up... 00:49:44 INFO - Return code: 0 00:49:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:49: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')]} 00:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe64030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11233b0>, '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 0x11242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124740>, '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': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', '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 00:49:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:49:44 INFO - Using env: {'DISPLAY': ':0', 00:49:44 INFO - 'HOME': '/home/cltbld', 00:49:44 INFO - 'LANG': 'en_US.UTF-8', 00:49:44 INFO - 'LANGUAGE': 'en_US:en', 00:49:44 INFO - 'LOGNAME': 'cltbld', 00:49:44 INFO - 'MAIL': '/var/mail/cltbld', 00:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:44 INFO - 'MOZ_NO_REMOTE': '1', 00:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:44 INFO - 'NO_EM_RESTART': '1', 00:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:44 INFO - 'PWD': '/builds/slave/test', 00:49:44 INFO - 'SHELL': '/bin/bash', 00:49:44 INFO - 'SHLVL': '1', 00:49:44 INFO - 'TERM': 'linux', 00:49:44 INFO - 'TMOUT': '86400', 00:49:44 INFO - 'USER': 'cltbld', 00:49:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', 00:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:44 INFO - '_': '/tools/buildbot/bin/python'} 00:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:49:44 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 00:49:44 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 00:49:44 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 00:49:44 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 00:49:44 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 00:49:44 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 00:49:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:49:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:49:46 INFO - Installing collected packages: mozsystemmonitor 00:49:46 INFO - Running setup.py install for mozsystemmonitor 00:49:46 INFO - Successfully installed mozsystemmonitor 00:49:46 INFO - Cleaning up... 00:49:46 INFO - Return code: 0 00:49:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:49: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')]} 00:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:46 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 0xe64030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11233b0>, '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 0x11242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124740>, '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': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', '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 00:49:46 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 00:49:46 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 00:49:46 INFO - Using env: {'DISPLAY': ':0', 00:49:46 INFO - 'HOME': '/home/cltbld', 00:49:46 INFO - 'LANG': 'en_US.UTF-8', 00:49:46 INFO - 'LANGUAGE': 'en_US:en', 00:49:46 INFO - 'LOGNAME': 'cltbld', 00:49:46 INFO - 'MAIL': '/var/mail/cltbld', 00:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:46 INFO - 'MOZ_NO_REMOTE': '1', 00:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:46 INFO - 'NO_EM_RESTART': '1', 00:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:46 INFO - 'PWD': '/builds/slave/test', 00:49:46 INFO - 'SHELL': '/bin/bash', 00:49:46 INFO - 'SHLVL': '1', 00:49:46 INFO - 'TERM': 'linux', 00:49:46 INFO - 'TMOUT': '86400', 00:49:46 INFO - 'USER': 'cltbld', 00:49:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', 00:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:46 INFO - '_': '/tools/buildbot/bin/python'} 00:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:46 INFO - Downloading/unpacking jsonschema==2.5.1 00:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:49:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:48 INFO - Downloading functools32-3.2.3-2.tar.gz 00:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:49:48 INFO - warning: no files found matching '*.txt' 00:49:48 INFO - no previously-included directories found matching 'build' 00:49:48 INFO - no previously-included directories found matching 'dist' 00:49:48 INFO - no previously-included directories found matching '.git*' 00:49:48 INFO - Installing collected packages: jsonschema, functools32 00:49:48 INFO - Running setup.py install for functools32 00:49:48 INFO - warning: no files found matching '*.txt' 00:49:48 INFO - no previously-included directories found matching 'build' 00:49:48 INFO - no previously-included directories found matching 'dist' 00:49:48 INFO - no previously-included directories found matching '.git*' 00:49:48 INFO - Successfully installed jsonschema functools32 00:49:48 INFO - Cleaning up... 00:49:48 INFO - Return code: 0 00:49:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe64030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11233b0>, '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 0x11242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124740>, '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': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', '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 00:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:49:48 INFO - Using env: {'DISPLAY': ':0', 00:49:48 INFO - 'HOME': '/home/cltbld', 00:49:48 INFO - 'LANG': 'en_US.UTF-8', 00:49:48 INFO - 'LANGUAGE': 'en_US:en', 00:49:48 INFO - 'LOGNAME': 'cltbld', 00:49:48 INFO - 'MAIL': '/var/mail/cltbld', 00:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:48 INFO - 'MOZ_NO_REMOTE': '1', 00:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:48 INFO - 'NO_EM_RESTART': '1', 00:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:48 INFO - 'PWD': '/builds/slave/test', 00:49:48 INFO - 'SHELL': '/bin/bash', 00:49:48 INFO - 'SHLVL': '1', 00:49:48 INFO - 'TERM': 'linux', 00:49:48 INFO - 'TMOUT': '86400', 00:49:48 INFO - 'USER': 'cltbld', 00:49:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', 00:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:48 INFO - '_': '/tools/buildbot/bin/python'} 00:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:49 INFO - Downloading/unpacking blobuploader==1.2.4 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 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 00:49:50 INFO - Downloading blobuploader-1.2.4.tar.gz 00:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:49:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:49:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:51 INFO - Downloading docopt-0.6.1.tar.gz 00:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:49:51 INFO - Installing collected packages: blobuploader, requests, docopt 00:49:51 INFO - Running setup.py install for blobuploader 00:49:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:49:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:49:51 INFO - Running setup.py install for requests 00:49:52 INFO - Running setup.py install for docopt 00:49:52 INFO - Successfully installed blobuploader requests docopt 00:49:52 INFO - Cleaning up... 00:49:52 INFO - Return code: 0 00:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:52 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 0xe64030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11233b0>, '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 0x11242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124740>, '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': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', '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 00:49:52 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 00:49:52 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 00:49:52 INFO - Using env: {'DISPLAY': ':0', 00:49:52 INFO - 'HOME': '/home/cltbld', 00:49:52 INFO - 'LANG': 'en_US.UTF-8', 00:49:52 INFO - 'LANGUAGE': 'en_US:en', 00:49:52 INFO - 'LOGNAME': 'cltbld', 00:49:52 INFO - 'MAIL': '/var/mail/cltbld', 00:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:52 INFO - 'MOZ_NO_REMOTE': '1', 00:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:52 INFO - 'NO_EM_RESTART': '1', 00:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:52 INFO - 'PWD': '/builds/slave/test', 00:49:52 INFO - 'SHELL': '/bin/bash', 00:49:52 INFO - 'SHLVL': '1', 00:49:52 INFO - 'TERM': 'linux', 00:49:52 INFO - 'TMOUT': '86400', 00:49:52 INFO - 'USER': 'cltbld', 00:49:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', 00:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:52 INFO - '_': '/tools/buildbot/bin/python'} 00:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:49:52 INFO - Running setup.py (path:/tmp/pip-5kLUmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:49:52 INFO - Running setup.py (path:/tmp/pip-FD1Gn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:49:52 INFO - Running setup.py (path:/tmp/pip-gswO4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:49:52 INFO - Running setup.py (path:/tmp/pip-m3bzga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:49:52 INFO - Running setup.py (path:/tmp/pip-e748E0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:49:52 INFO - Running setup.py (path:/tmp/pip-t8Fb9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:49:53 INFO - Running setup.py (path:/tmp/pip-ePVMIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:49:53 INFO - Running setup.py (path:/tmp/pip-hGe0Zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:49:53 INFO - Running setup.py (path:/tmp/pip-63ts4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:49:53 INFO - Running setup.py (path:/tmp/pip-jX0Wy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:49:53 INFO - Running setup.py (path:/tmp/pip-sShLdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:49:53 INFO - Running setup.py (path:/tmp/pip-DJ94Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:49:53 INFO - Running setup.py (path:/tmp/pip-m_uDCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:49:53 INFO - Running setup.py (path:/tmp/pip-7cK2TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:53 INFO - Running setup.py (path:/tmp/pip-ksVDfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:49:53 INFO - Running setup.py (path:/tmp/pip-x6U_Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:49:53 INFO - Running setup.py (path:/tmp/pip-Icea2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:49:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:49:53 INFO - Running setup.py install for manifestparser 00:49:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:49:53 INFO - Running setup.py install for mozcrash 00:49:54 INFO - Running setup.py install for mozdebug 00:49:54 INFO - Running setup.py install for mozdevice 00:49:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:49:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:49:54 INFO - Running setup.py install for mozfile 00:49:54 INFO - Running setup.py install for mozhttpd 00:49:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:49:54 INFO - Running setup.py install for mozinfo 00:49:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:49:54 INFO - Running setup.py install for mozInstall 00:49:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:49:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:49:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:49:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:49:54 INFO - Running setup.py install for mozleak 00:49:54 INFO - Running setup.py install for mozlog 00:49:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:49:54 INFO - Running setup.py install for moznetwork 00:49:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:49:54 INFO - Running setup.py install for mozprocess 00:49:55 INFO - Running setup.py install for mozprofile 00:49:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:49:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:49:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:49:55 INFO - Running setup.py install for mozrunner 00:49:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:49:55 INFO - Running setup.py install for mozscreenshot 00:49:55 INFO - Running setup.py install for moztest 00:49:55 INFO - Running setup.py install for mozversion 00:49:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:49:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:49:55 INFO - Cleaning up... 00:49:55 INFO - Return code: 0 00:49:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:55 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 0xe64030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11233b0>, '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 0x11242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124740>, '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': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', '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 00:49:55 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 00:49:55 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 00:49:55 INFO - Using env: {'DISPLAY': ':0', 00:49:55 INFO - 'HOME': '/home/cltbld', 00:49:55 INFO - 'LANG': 'en_US.UTF-8', 00:49:55 INFO - 'LANGUAGE': 'en_US:en', 00:49:55 INFO - 'LOGNAME': 'cltbld', 00:49:55 INFO - 'MAIL': '/var/mail/cltbld', 00:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:55 INFO - 'MOZ_NO_REMOTE': '1', 00:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:55 INFO - 'NO_EM_RESTART': '1', 00:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:55 INFO - 'PWD': '/builds/slave/test', 00:49:55 INFO - 'SHELL': '/bin/bash', 00:49:55 INFO - 'SHLVL': '1', 00:49:55 INFO - 'TERM': 'linux', 00:49:55 INFO - 'TMOUT': '86400', 00:49:55 INFO - 'USER': 'cltbld', 00:49:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', 00:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:55 INFO - '_': '/tools/buildbot/bin/python'} 00:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:49:55 INFO - Running setup.py (path:/tmp/pip-Ryq3_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:49:55 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)) 00:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:49:55 INFO - Running setup.py (path:/tmp/pip-55uzAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:49:55 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)) 00:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:49:55 INFO - Running setup.py (path:/tmp/pip-yt2HBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:49:56 INFO - Running setup.py (path:/tmp/pip-_rNbBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:49:56 INFO - Running setup.py (path:/tmp/pip-ztg7yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:49:56 INFO - Running setup.py (path:/tmp/pip-QnHx6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:49:56 INFO - Running setup.py (path:/tmp/pip-i12dQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:49:56 INFO - Running setup.py (path:/tmp/pip-oMUcgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:49:56 INFO - Running setup.py (path:/tmp/pip-YwsTRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:49:56 INFO - Running setup.py (path:/tmp/pip-gRfFNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:49:56 INFO - Running setup.py (path:/tmp/pip-N29yn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:49:56 INFO - Running setup.py (path:/tmp/pip-TShJLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:49:56 INFO - Running setup.py (path:/tmp/pip-hKIKl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:49:56 INFO - Running setup.py (path:/tmp/pip-sh36wB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:56 INFO - Running setup.py (path:/tmp/pip-afZObS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:49:56 INFO - Running setup.py (path:/tmp/pip-eJPv0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:49:56 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)) 00:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:49:56 INFO - Running setup.py (path:/tmp/pip-Xtgerj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:59 INFO - Downloading blessings-1.6.tar.gz 00:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:49:59 INFO - Installing collected packages: blessings 00:49:59 INFO - Running setup.py install for blessings 00:49:59 INFO - Successfully installed blessings 00:49:59 INFO - Cleaning up... 00:49:59 INFO - Return code: 0 00:49:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:50:00 INFO - Reading from file tmpfile_stdout 00:50:00 INFO - Current package versions: 00:50:00 INFO - argparse == 1.2.1 00:50:00 INFO - blessings == 1.6 00:50:00 INFO - blobuploader == 1.2.4 00:50:00 INFO - docopt == 0.6.1 00:50:00 INFO - functools32 == 3.2.3-2 00:50:00 INFO - jsonschema == 2.5.1 00:50:00 INFO - manifestparser == 1.1 00:50:00 INFO - mozInstall == 1.12 00:50:00 INFO - mozcrash == 0.17 00:50:00 INFO - mozdebug == 0.1 00:50:00 INFO - mozdevice == 0.48 00:50:00 INFO - mozfile == 1.2 00:50:00 INFO - mozhttpd == 0.7 00:50:00 INFO - mozinfo == 0.9 00:50:00 INFO - mozleak == 0.1 00:50:00 INFO - mozlog == 3.2 00:50:00 INFO - moznetwork == 0.27 00:50:00 INFO - mozprocess == 0.22 00:50:00 INFO - mozprofile == 0.28 00:50:00 INFO - mozrunner == 6.11 00:50:00 INFO - mozscreenshot == 0.1 00:50:00 INFO - mozsystemmonitor == 0.3 00:50:00 INFO - moztest == 0.7 00:50:00 INFO - mozversion == 1.4 00:50:00 INFO - psutil == 3.1.1 00:50:00 INFO - requests == 1.2.3 00:50:00 INFO - wsgiref == 0.1.2 00:50:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:50:00 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')]} 00:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:00 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')]} 00:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:00 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 0xe64030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11233b0>, '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 0x11242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124740>, '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': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', '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 00:50:00 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 00:50:00 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 00:50:00 INFO - Using env: {'DISPLAY': ':0', 00:50:00 INFO - 'HOME': '/home/cltbld', 00:50:00 INFO - 'LANG': 'en_US.UTF-8', 00:50:00 INFO - 'LANGUAGE': 'en_US:en', 00:50:00 INFO - 'LOGNAME': 'cltbld', 00:50:00 INFO - 'MAIL': '/var/mail/cltbld', 00:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:00 INFO - 'MOZ_NO_REMOTE': '1', 00:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:00 INFO - 'NO_EM_RESTART': '1', 00:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:00 INFO - 'PWD': '/builds/slave/test', 00:50:00 INFO - 'SHELL': '/bin/bash', 00:50:00 INFO - 'SHLVL': '1', 00:50:00 INFO - 'TERM': 'linux', 00:50:00 INFO - 'TMOUT': '86400', 00:50:00 INFO - 'USER': 'cltbld', 00:50:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', 00:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:00 INFO - '_': '/tools/buildbot/bin/python'} 00:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:00 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)) 00:50:00 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)) 00:50:00 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)) 00:50:00 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)) 00:50:00 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)) 00:50:00 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)) 00:50:00 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)) 00:50:00 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)) 00:50:00 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)) 00:50:00 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)) 00:50:00 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)) 00:50:00 INFO - Cleaning up... 00:50:00 INFO - Return code: 0 00:50:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:50:00 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')]} 00:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:00 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')]} 00:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:00 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 0xe64030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11233b0>, '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 0x11242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124740>, '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': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', '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 00:50:00 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 00:50:00 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 00:50:00 INFO - Using env: {'DISPLAY': ':0', 00:50:00 INFO - 'HOME': '/home/cltbld', 00:50:00 INFO - 'LANG': 'en_US.UTF-8', 00:50:00 INFO - 'LANGUAGE': 'en_US:en', 00:50:00 INFO - 'LOGNAME': 'cltbld', 00:50:00 INFO - 'MAIL': '/var/mail/cltbld', 00:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:00 INFO - 'MOZ_NO_REMOTE': '1', 00:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:00 INFO - 'NO_EM_RESTART': '1', 00:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:00 INFO - 'PWD': '/builds/slave/test', 00:50:00 INFO - 'SHELL': '/bin/bash', 00:50:00 INFO - 'SHLVL': '1', 00:50:00 INFO - 'TERM': 'linux', 00:50:00 INFO - 'TMOUT': '86400', 00:50:00 INFO - 'USER': 'cltbld', 00:50:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', 00:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:00 INFO - '_': '/tools/buildbot/bin/python'} 00:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:50:00 INFO - Cleaning up... 00:50:00 INFO - Return code: 0 00:50:00 INFO - Running post-action listener: _resource_record_post_action 00:50:00 INFO - Running post-action listener: _start_resource_monitoring 00:50:00 INFO - Starting resource monitoring. 00:50:00 INFO - ##### 00:50:00 INFO - ##### Finished create-virtualenv step (success) 00:50:00 INFO - ##### 00:50:00 INFO - ##### 00:50:00 INFO - ##### Running install step. 00:50:00 INFO - ##### 00:50:00 INFO - Running pre-action listener: _resource_record_pre_action 00:50:00 INFO - Running main action method: install 00:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:50:00 INFO - Reading from file tmpfile_stdout 00:50:00 INFO - Detecting whether we're running mozinstall >=1.0... 00:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:50:00 INFO - Reading from file tmpfile_stdout 00:50:00 INFO - Output received: 00:50:00 INFO - Usage: mozinstall [options] installer 00:50:00 INFO - Options: 00:50:00 INFO - -h, --help show this help message and exit 00:50:00 INFO - -d DEST, --destination=DEST 00:50:00 INFO - Directory to install application into. [default: 00:50:00 INFO - "/builds/slave/test"] 00:50:00 INFO - --app=APP Application being installed. [default: firefox] 00:50:00 INFO - mkdir: /builds/slave/test/build/application 00:50:00 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'] 00:50:00 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 00:50:17 INFO - Reading from file tmpfile_stdout 00:50:17 INFO - Output received: 00:50:17 INFO - /builds/slave/test/build/application/firefox/firefox 00:50:17 INFO - Running post-action listener: _resource_record_post_action 00:50:17 INFO - ##### 00:50:17 INFO - ##### Finished install step (success) 00:50:17 INFO - ##### 00:50:17 INFO - ##### 00:50:17 INFO - ##### Running run-tests step. 00:50:17 INFO - ##### 00:50:17 INFO - Running pre-action listener: _resource_record_pre_action 00:50:17 INFO - Running main action method: run_tests 00:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:50:17 INFO - Python 2.7.3 00:50:17 INFO - Return code: 0 00:50:17 INFO - grabbing minidump binary from tooltool 00:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:17 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 0x11233b0>, '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 0x11242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:50:17 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 00:50:17 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 00:50:17 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 00:50:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:50:17 INFO - Return code: 0 00:50:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:50:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:50:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:50:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:50:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:50:17 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/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 00:50:17 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/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 00:50:17 INFO - Using env: {'DISPLAY': ':0', 00:50:17 INFO - 'HOME': '/home/cltbld', 00:50:17 INFO - 'LANG': 'en_US.UTF-8', 00:50:17 INFO - 'LANGUAGE': 'en_US:en', 00:50:17 INFO - 'LOGNAME': 'cltbld', 00:50:17 INFO - 'MAIL': '/var/mail/cltbld', 00:50:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:50:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:17 INFO - 'MOZ_NO_REMOTE': '1', 00:50:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:17 INFO - 'NO_EM_RESTART': '1', 00:50:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:17 INFO - 'PWD': '/builds/slave/test', 00:50:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:50:17 INFO - 'SHELL': '/bin/bash', 00:50:17 INFO - 'SHLVL': '1', 00:50:17 INFO - 'TERM': 'linux', 00:50:17 INFO - 'TMOUT': '86400', 00:50:17 INFO - 'USER': 'cltbld', 00:50:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439', 00:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:17 INFO - '_': '/tools/buildbot/bin/python'} 00:50:17 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/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 00:50:17 INFO - mozversion application_buildid: 20160628071022 00:50:17 INFO - mozversion application_changeset: e45890951ce77c3df05575bd54072b9f300d77b0 00:50:17 INFO - mozversion application_display_name: Nightly 00:50:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:50:17 INFO - mozversion application_name: Firefox 00:50:17 INFO - mozversion application_remotingname: firefox 00:50:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:50:17 INFO - mozversion application_vendor: Mozilla 00:50:17 INFO - mozversion application_version: 50.0a1 00:50:17 INFO - mozversion platform_buildid: 20160628071022 00:50:17 INFO - mozversion platform_changeset: e45890951ce77c3df05575bd54072b9f300d77b0 00:50:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:50:17 INFO - mozversion platform_version: 50.0a1 00:50:17 INFO - using testdate: 1467186617 00:50:17 INFO - actual date: 1467186617 00:50:17 INFO - starting webserver on 'localhost:45371' 00:50:17 INFO - SUITE-START | Running 2 tests 00:50:17 INFO - TEST-START | dromaeo_css 00:50:17 INFO - operating with platform_type : linux_ 00:50:17 INFO - Initialising browser for dromaeo_css test... 00:50:17 INFO - TEST-INFO | started process 16172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUze2zp/profile http://localhost:45371/getInfo.html) 00:50:21 INFO - PROCESS | 16172 | __metrics Screen width/height:1600/1200 00:50:21 INFO - PROCESS | 16172 | colorDepth:24 00:50:21 INFO - PROCESS | 16172 | Browser inner width/height: 1024/697 00:50:21 INFO - PROCESS | 16172 | __metrics 00:50:22 INFO - PROCESS | 16172 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:50:23 INFO - TEST-INFO | 16172: exit 0 00:50:23 INFO - Browser initialized. 00:50:23 INFO - Running cycle 1/1 for dromaeo_css test... 00:50:23 INFO - TEST-INFO | started process 16254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUze2zp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:50:35 INFO - PROCESS | 16254 | RSS: Main: 157925376 00:50:35 INFO - PROCESS | 16254 | 00:51:26 INFO - PROCESS | 16254 | 1467186686281 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] 00:53:39 INFO - PROCESS | 16254 | Cycle 1(1): loaded http://localhost:45371/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45371/tests/dromaeo/cssquery-ext.html) 00:53:40 INFO - PROCESS | 16254 | RSS: Main: 242237440 00:53:40 INFO - PROCESS | 16254 | 00:56:42 INFO - PROCESS | 16254 | Cycle 1(1): loaded http://localhost:45371/tests/dromaeo/cssquery-ext.html (next: http://localhost:45371/tests/dromaeo/cssquery-jquery.html) 00:56:43 INFO - PROCESS | 16254 | RSS: Main: 248676352 00:56:43 INFO - PROCESS | 16254 | 00:59:45 INFO - PROCESS | 16254 | Cycle 1(1): loaded http://localhost:45371/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45371/tests/dromaeo/cssquery-mootools.html) 00:59:46 INFO - PROCESS | 16254 | RSS: Main: 244117504 00:59:46 INFO - PROCESS | 16254 | 01:02:48 INFO - PROCESS | 16254 | Cycle 1(1): loaded http://localhost:45371/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45371/tests/dromaeo/cssquery-prototype.html) 01:02:48 INFO - PROCESS | 16254 | RSS: Main: 241414144 01:02:48 INFO - PROCESS | 16254 | 01:05:51 INFO - PROCESS | 16254 | Cycle 1(1): loaded http://localhost:45371/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45371/tests/dromaeo/cssquery-yui.html) 01:05:52 INFO - PROCESS | 16254 | RSS: Main: 217206784 01:05:52 INFO - PROCESS | 16254 | 01:08:55 INFO - PROCESS | 16254 | Cycle 1(1): loaded http://localhost:45371/tests/dromaeo/cssquery-yui.html (next: http://localhost:45371/tests/dromaeo/cssquery-dojo.html) 01:08:55 INFO - PROCESS | 16254 | RSS: Main: 278290432 01:08:55 INFO - PROCESS | 16254 | 01:08:55 INFO - PROCESS | 16254 | __start_tp_report 01:08:55 INFO - PROCESS | 16254 | _x_x_mozilla_page_load 01:08:55 INFO - PROCESS | 16254 | _x_x_mozilla_page_load_details 01:08:55 INFO - PROCESS | 16254 | |i|pagename|runs| 01:08:55 INFO - PROCESS | 16254 | |0;dojo.html;2627.146177492315;2643.6563246777914;2666.8133230673848;2688.4354285600034;2692.6634170728657;4684.695494792836;4728.267118596618;4752.097101550703;4803.711777293365;4871.902561948763;4772.642051846116;4809.086273608012;4820.060088282787;4825.445073816512;4879.414470263565;4332.06860524987;4400.911981760363;4477.395551600524;4534.34252033455;4536.364908912755;4463.910721785563;4497.797599108032;4505.166544189319;4511.751853648048;4536.410266665345;4330.740155590644;4344.91310173798;4367.71609845359;4371.78141092944;4410.382546443484;4361.912761744779;4372.147431250907;4374.03771170342;4412.492563355191;4421.336799480072;4398.296272596402;4403.383526306319;4410.933835992462;4448.911021779546;4466.307722303049;4681.204195286809;4731.124741922756;4762.38089048425;4775.426948766136;4798.1123492154065;5165.9225111623355;5201;5214.270002199695;5216.713080780555;5230.581553475713;5211.1922651989;5251.054810134175;5258.237555554423;5261.552768014685;5263.6578622389425;4679.274712419615;4786.7845946932475;4814.7833347499445;4823.083614113307;4881.731504767201;5327.174287985291;5353.357597088297;5355.143177091647;5357.624966252403;5360.115580929181;4896.755162241873;5106;5138.409082955508;5152.149895267239;5158.097332966716;5145.22821576759;5169.25045868347;5175.249588809602;5205.817796377184;5219.164933610604;5155.278261043457;5161.096808058574;5180.585553155738;5180.637355385087;5228.790848366023;4954.281629163823;5062.848114556569;5130.230465430215;5141.460146684619;5145.614078944094;4407.0524837160165;4411.911761764747;4417.602415782595;4463.04044630406;4475.30632751924;3833.0609000794984;3837.9424308635394;3843.2313537292653;3866.5553461352306;3879.9030024249055;4348.760818155032;4390.407295015196;4447.844325448594;4493.573110554492;4500.099980004013;5125;5132.794688212504;5173.560247379015;5181.1969144782615;5203.323567936144;4443.911121777611;4448.844290449883;4455.866324010285;4463.366474517438;4492.707973981681;4581.335706322565;4581.5647513486165;4582.152301824173;4680.180968330528;4715.434147902273;4765.9523404765505;4787;4799.736014519095;4837.22604383304;4842.346283251716;5133.845984620468;5143.794248230029;5149.304843846033;5149.304843846033;5150;4648.3027545867035;4781.306710527024;4783.617310615212;4801.135795556694;4809.278608208797;5101.540861322499;5113.8721531962;5147.485251474823;5147.794088236578;5189.117849965591;5166.2767212589515;5186.377634683711;5190.117679994334;5199.636025478331;5200.375954885438;4910.8281210157475;4976.353074100344;5058.190689489664;5064.924026139537;5091.109055915126;4886.096072226649;4887.633427492881;4892.535209155125;4903.460619331942;4932.802687892444;4819.638527110411;4830.9854930465;4840.056189043244;4883.731394773322;4889.608831293559;4932.136876046606;4978.253262010582;4999.500049994971;5000.024995125916;5019.623528235324;4943.2585112233455;4953.455119936876;4957.206846904478;4958.1323268428605;5005.949940500548 01:08:55 INFO - PROCESS | 16254 | |1;ext.html;573.8766165274466;575.985600359991;578.3291381996885;597.8087012156112;604.9909251361233;29388.85305573472;39170;41334.79332603333;41396.79301603495;44836.77581612088;41538.16923661525;41926.161476770445;42098.789506052504;42111;42167;7761.844763104735;7903.762887113396;7905.565193914361;7909.24862138096;7914.208579142069;7692.153863075086;7766.068071831388;7779;7779.922200777976;7783.104942931551;7815.687372505093;7872.645730942093;7873.881891771628;7874.448788584801;7876.251756083191;7777.494462859924;7800.18098099697;7817.452778305521;7820.257075577811;7822.765317040498;7569.356604688553;7635.656395462218;7643.656035478417;7643.923560764377;7644.159142494321;39170.804145979375;39369.40945885814;39435.60564394348;39532;39609.207815843525;2870.354170311684;3078.2612173078523;3254.723348515355;3584.874529391459;3680.0799800049986;27607.86196069027;28933.56599650986;30864.228394290323;30955.690443095507;30958.0712578623;3452.1369657585606;3551.200979779555;3587.3184095022125;3633.9273214535824;3673.210259794157;109287.45356273168;110029;110099;110460;110789;51205.7439712799;57613.71193144008;59104;60203.39796602065;60370;57843.42156578464;58165.41834581685;58199.4180058194;58288.4171158283;58343.416565833795;15280.159591222367;15528.689426211413;15550.533483995498;15576.922115389578;15581.454649087227;10691.679249622524;10907.83638245427;11663.825042624367;11739.178257521891;11808;16761.83238167627;18720.25118995225;19310.80701512334;20242.3806095512;20438;7252.709891604382;7335.816604584928;7366.263373662591;7427.665755041036;7692;821.9178082191733;841.2344766262671;875.7504111328241;898.797770501645;991.1674193677345;28395.148145555668;28700.425991480053;28940.27649308784;29422.558661620093;29739.405211895642;926.1988380051207;928.8978212396631;964.7925695975399;1006.3257617396362;1008.6613309944108;13961.930190348983;14715.484958026418;14811.033689823833;14839.851601483848;14919.254037298091;367463;370498;371900;372593;372933;50240;50952.490475094775;50982.235266471034;51017.74491127521;51102.744486278076;1070.71626019105;1128.514738662383;1164.8776878427982;1187.6674531131298;1235.3576140407117;28156.71843281623;29418.26454338573;29531;30156.54765178568;30205.244868878453;43411.78294108509;44237.557624423345;44294.335584966895;44349.55650443583;44384;306171;309387;310141;310309;310706;25837.89945206587;27525.587116193674;28476.145715628565;28675.13974580766;28846.278843029093;43616.56383436125;43644.78177609092;43658.56341436672;44663.33005004862;44688.32967505555;37098.44352334663;37380.62619373771;37508.624913750515;37651;38633;37037.25925481529;37842.243155136195;37902;38025.80987095047;38090.80954595209;36576.81711591425;37227.06932326713;37599.624003759614;37655.24689506249;37885;33173.83413082919;33405.83297083499;33891.49162762511;35268.823655881555;35537.82231088828;25914.481710366064;25980.35049123787;26123.608145877446;26230.606540902285;26289.73710262873 01:08:55 INFO - PROCESS | 16254 | |2;jquery.html;354.9290141971606;356.5400633183192;356.6665168067856;365.2749292654083;372.68135743938933;16054.51836444907;17156.914215428922;17507.73738393925;17507.91246043771;17552.297908083663;16327.34690612377;16902.323907043734;17310.653786924253;17330.74003889943;17342.739858902125;4865.805367785284;5095.464976177485;5098.847034588968;5124.487551244864;5138.563222126124;3691.095681558022;3911.9413208801748;5080.491950804909;5755.280589926259;6076.939230607703;6093.847653808646;6094.847628809271;6140.048292514667;6141.324454310023;6144.078388241777;5838.153467747175;6086.756529738849;6090.939090609104;6094.847628809271;6110.236220472441;3246.4318744219668;4968.577670897978;5283.682979021232;5289.127293996486;5296.655717378358;19739.605207895762;20421.081051352576;20448.693269600968;20678.069486872977;20719.689204661943;1995.4013795861183;2174.3368272676985;2335.801456876168;2582.1995181493608;2606.9217923462325;12565.497380104785;13298.40157192919;13404.798928016087;13613.795793063113;13918.30408479572;1744.8080711121765;1817.155022914338;1867.4304337177155;1867.7945426003264;1876.5965317456812;68176;68353.97469038019;68826.31173688249;68900;69936.30063699349;9327.207187389013;9333.486658233862;9605.327627066177;9607.759806004766;9784.608615655436;13019.869801302055;13084.149530280501;13100.541481048118;13133.080684352195;13146.079774415699;6955.130608673916;6974.476914231352;7021.613811240431;7036.155661320674;7161.39128174111;6686.96656516724;6715.731370745213;6873.415759660485;6876.484263680244;6891.036854152662;6022.1870047543025;6090.23872015998;6094.481969032593;6102.389761023951;6170.56806023583;1576.8501992310712;1634.9781386633354;1701.072915261161;1701.8128005919586;1741.0685283373334;824.8474032304043;850.9702160424356;884.9159329863653;898.6270697660528;946.8201041802173;16461.83538164603;16568.502944911674;16755.916220419065;17204.569885752706;17580.12099395025;870.0994470722771;881.5151666583354;908.3913777768779;923.35826600512;929.7907970706672;9790.5594248259;9906.80186396268;9980.550875210633;9981.550830212658;10099.949500252598;406651;409234;412766;423949;428268;64364.35635643677;67870.32129678738;68538.31461685419;68824;69235;891.8216356728681;896.5248418338291;948.1514044929887;948.6584829461389;949.8717673114179;15397.461088861835;15676.608084797972;15738.370465181264;15740.527784166494;16017.35930562811;38535.80732096321;38634.806825965694;38836.805815970736;39059.41410878782;39128.804355978034;52779.73610131925;54139.18791218056;54173;54238.64403389789;54271;7199.2440793715905;7444.255574442513;7560.659770310459;7660;7740.651670674946;10766.623168189075;11532.654020379403;11703.76592468129;11850.525978960744;11855.229410088317;10101.69694909154;10211.948940255252;10426.635067772591;10435.843462348223;10440.477976101316;9800.460974646177;10302.33034852732;10322.380657160595;10590.993855583707;10611.946940265248;10603.469826508797;10631.255812093079;10868.456577171268;10880.67357979262;10970.890291097307;6478.222613286436;6701.195856497252;6837.62393068386;7057.36483716468;7629.351505122127;7276.381507571704;8853.557322133738;9768.951155244178;10398.74003149897;10520 01:08:55 INFO - PROCESS | 16254 | |3;mootools.html;1216.1547724331592;1322.8478724946633;1363.8704323089305;1412.329143656763;1648.6867495175916;6600.471962243021;7370.852582948344;7655.770326890195;7659;7850.136484986647;7605.125410577785;7742.574158421285;7766;7767.184445633212;7768.223177682229;1844.1701234444486;2039.612473630013;2093.3405977117236;2098.7061811346384;2130.9680354794614;2168.56628674265;2175.7497887742875;2179.6294629912954;2181.945451363713;2183.0285522942295;2074.543600407908;2089.4985203551114;2144.3245377706053;2145.0454547726267;2147.699322094908;1774.0952114421673;1974.9506262343557;2039.1129858511595;2045.3148195354574;2097.056324653904;2080.8023237792386;2086.968695469569;2088.571842772228;2091.309867743656;2091.623507768601;7581.2418758124295;7652.426068044863;7691.692332306701;7692.538447693157;7694.499857509244;4235.894102647428;4335.8048887799805;4348.499922508889;4451.9777401113115;4471.217536931056;2649.523085844547;2728.181545536351;2739.4384151248946;2740.6026126211787;2741.7943654225814;860.5439117267858;887.6582515731425;906.3202598051462;911.9498427586481;913.5021413329752;10366.429846358447;10422.9478852606;10427.582896684124;10429.374237545695;10432.32189907661;3922.117523557177;3968.464257325282;4012.8996775080273;4032.334664780278;4136.276151673445;8811.603477843513;8813.338999575057;8814.382993190544;8824.602892869836;8825.646974121091;4574.199515084913;4596.126735920231;4598.172328980749;4598.517155698671;4601.585857272861;3535.611082780892;4074.7351422157467;4177.456930599003;4219.767912764827;4257.4252475915355;3536.8054756988613;3554.2713743682484;3561.786292822387;3653.8903832885057;3670.834812433447;1146.954121835134;1151.2746969409386;1155.930644161353;1164.4992653159222;1166.6383421139474;822.2024636102971;843.0641987393988;866.8353012927649;870.634333579898;870.7387783664875;4982.402111746614;5021.096202683552;5142;5261.4738526147075;5356.758945847446;386.5207143142483;388.40186113385636;390.1397418691778;392.3330338424689;394.61327898659476;3549.3611149992735;3595.3708101082207;3605.963940360563;3606.9098272543397;3647.2705458908326;9023.323250756219;9452.52737363129;9508.429494230368;9520.190783783317;9561.808763824823;9467.147956683793;9468.479233642078;9472.857907131398;9481.288903332277;9482.241420686329;6786.710525000333;6858.177018757781;6978.720851165896;7017.7192912282935;7037.507374483737;5037.395512538519;5074.264231686311;5085.288059671575;5109.284700142058;5160.509751573594;8694.565271736261;8707.521086340059;8729;8752.606132723915;8805.51569663649;8658.826823463369;8962.641494340414;8966.775830604287;8974;8986.910130898606;5880.588358815013;6085.3306136325855;6089.599392139744;6612.173478315211;6681.031250468558;6545.21457425112;6707.496937729592;7395.593242371721;7410.110786705414;7563.848723025619;6653.434458071119;6752.155980502437;6755.527113102035;6838.794836154923;6852.897206542006;6465.224173099258;6467.482601391972;6506.577072490273;6516.185476815398;6574.408303252731;6342.778002769881;6367.458766004941;6373.936260637334;6398.840028999312;6409.359064093554;4395.362672412546;4515.548445155589;4541.818327267005;4570.040291538681;4570.131674981742;4391.077873646443;4412.382266482759;4413.337999300131;4475.082608065273;4477.1493416250805 01:08:55 INFO - PROCESS | 16254 | |4;prototype.html;283.6596084698362;286.6835965399571;291.95766613840993;301.5100461749657;303.62805563185117;4816.590589799866;4843.612510999121;4849.175640141176;4857;4914.238293064572;4787.521247875211;4829.251466022772;4832.589229915461;4838.951610483894;4849.757512124388;3616.4756110363915;3707.2956138333766;3717.721170912179;3727.2172843702856;3732.2348918471785;3670.7614005089717;3736.8505259789576;3811.5235595550557;3813.599572044937;3813.9237215255816;3737.8317975691025;3753.7935413552245;3761.5674197467233;3762.322781899257;3783.2004316805505;3548.3258180945536;3726.925461490755;3760.905977350561;3762.9059273518105;3768.2275133597545;3238.3037646906027;3246.1722260823576;3249.610046794376;3249.772515923886;3253.4957081652383;4741.2651039089;4749.810007599692;4750.406199225097;4751.40607424072;4774.355462012619;4113;4243.875373026151;4265.7014009019385;4274.273373526508;4305.63402110821;4936.481669424695;4992.450830408652;5017.774200161001;5026.84919452417;5031.371078615173;3563.467708885178;3584.2258082249455;3586.4620306953907;3593.766405183681;3601;5169.922451163236;5262.1319431602;5285.973570132163;5332.306800115999;5350.217886698895;3573.6426357364576;3610.530631017951;3615.8011309378235;3626.3472574936236;3629.94555081674;3646.6171052039685;3649.1789347397153;3652.945205821915;3653.5250417445563;3656.6526180012856;4212.85255016073;4217.599328063829;4221.767802770815;4242.618164365222;4246.214450326699;4860.930595269035;5126.79492820283;5129.615278854101;5132.204508301219;5138.486151384906;1276.8723127687158;1290.1678417420899;1294.4304506017322;1294.5080869269618;1298.441670081855;791.5409062743595;795.9442839001214;814.8370325934836;823.2261674026396;825.195434451405;4358.280883654162;4484.080763443486;4487.955120448819;4524.547545245449;4532.846897723555;5252.345511164048;5261.316378758837;5266.3943646480375;5297.576193904479;5299.549538289211;4448.288273876229;4451.265541185733;4455.175792478337;4461.799219035086;4526.479454862733;2622.501724672306;2767.6540432445945;2768.269831355403;2794.413173233603;2802.047303916678;4891.584215341664;4905.607551395879;4907.50321152052;4918.213085906309;4937.23472861707;5170.515407418494;5283.52448279649;5317.361916570037;5369.221462887859;5392.514673679388;4882.096812089775;4895.608351331956;4899.853004409873;4902.313676085351;4905.5094490550655;5215.55667768244;5225.92161117576;5245.9475405246985;5259.21111833228;5284.497972692588;4869.391326084239;5122.436531981404;5126.8974620508125;5127.87180320495;5165.61257905651;4824.638152138534;4867.245576935581;4884.853454396374;4915.26271059344;4931.901361972812;3632.4551317302617;3661.8901432957055;3697.4823524706026;3699.5560532736245;3706.314331848617;5144.4855514449755;5214.687118772886;5287.709175995357;5291.968066227048;5304.257403963526;5068.442471328225;5068.543831055223;5099.847004589868;5141.817382002086;5149.613778966517;5116.083832215601;5138.845834624967;5141.820036298712;5166.276721259102;5176.249443830548;4870.245112007645;5050.444451110448;5052.949470505395;5054.949450505448;5062.31658726082;4921.646547199549;5048.318477005557;5136.686836990046;5150.48495150482;5182;4984.37695288089;5008.672701734116;5015;5052.494750525065;5059.898802024012 01:08:55 INFO - PROCESS | 16254 | |5;yui.html;631.5579094633756;642.5245318464334;645.6610279603204;725.9346658800707;739.5008369350688;12369.567065152722;13085.738285234289;13162.341882905865;13167.47330106797;13188.736225275501;12299;12308.446119924602;12332.753344933097;12448.502059917593;12902.096853220279;614.9631022138686;755.5919803306208;783.4163548156631;799.0451410564378;801.5391150088693;789.6328207383566;802.0976401548259;802.1136644008375;803.1968031968032;804.2600807257337;842.2335674536173;842.8819965204876;844.8563744163507;845.4251109245711;846.4159729786459;638.3520726462644;788.1842293226483;823.7322870067193;830.8255266394034;832.068083746205;608.5283904973636;608.6865264388844;609.0103581679771;609.4088733928082;611.1840692675283;12737.808932866015;12787.424565894464;12807.551735689207;12822.679433014157;12828.166169198972;11061.336319820837;12417.254964702057;12700.682482937907;12892.419841107172;13106.082574219809;11404.201705880592;11621.360825154614;11745.354005529693;11813.586524471602;12093.637190884288;4047.7571345719352;4081.8163182656854;4177.039280965395;4253.787310634487;4254.914901701949;66001.66999165021;66665;66882.33117668859;67649.66175169093;68816;10193.286469947181;10262.640807571699;10265.384076955406;10276.177905767521;10626.681199564026;16013.279402426919;16191.271392787352;16236.837631623768;16820;17749.55626109332;7079.929200707927;7091.89362159568;7160.462965277625;7160.785176444715;7234.348908598146;3644.9715937406454;3645.2891686121484;3775.075106598846;3777.244551089793;3816.31306364857;2834.1214223590755;2965.481040817848;2965.724738362525;2967.3768508613;2969.6733359330456;488.27003629573306;488.5236894028294;501.03800702651;505.4036237240019;505.49703045469994;457.4510587295259;579.9420057994167;606.3663471672113;612.9478994285447;634.0932466572846;8331.625076871554;8510.148985101441;8534.957325213334;8645;8663.870041949376;592.2508027345411;604.8246008657441;608.1303735657963;608.9878202436015;615.3323643846387;3926;4088.1823635273063;4092.7748973806133;4127.112670775798;4272.957270427256;92092;92099;93367;97873;97913;48253;63980.68009660015;78102.60948695334;78220.21779782244;78560.60719696365;45457.31814022792;72048;73178;73543.89684154742;75862;7600.771976840703;7709.614519273901;7825.960870195612;7947.3244774194845;8043.19568043191;42714.35928461013;43871.56128438675;45142;45166;45198.774006131076;61950.38049619627;63915;64377;64904.350956489834;65045.67477162584;9658.179054780423;9981.101700846668;9996.900030999597;10109.19126469866;11081.39052352096;12137.635870923887;12652.510617037222;12704;13174.275414852274;13851.65370865696;11631.418429078682;11911.931406770615;12322.383880806103;12378.319192444502;12475.189112707645;11900.107491937966;11922.52309907594;11946.76106477883;12145;12198.390080495763;11492.770144596894;11884.227525210834;12068.456919438822;12170.513179472722;12362.876371236533;9577.185939195246;9714.271429642946;9932.503374831374;10047.296689231684;10367.587175169489;10369.377837329785;10405.9479702601;10427.791444170922;10773.730656733644;10897.073748731447 01:08:55 INFO - PROCESS | 16254 | __end_tp_report 01:08:55 INFO - PROCESS | 16254 | __start_cc_report 01:08:55 INFO - PROCESS | 16254 | _x_x_mozilla_cycle_collect,938 01:08:55 INFO - PROCESS | 16254 | __end_cc_report 01:08:55 INFO - PROCESS | 16254 | __startTimestamp1467187735742__endTimestamp 01:08:55 INFO - PROCESS | 16254 | 01:08:55 INFO - PROCESS | 16254 | ------- Summary: start ------- 01:08:55 INFO - PROCESS | 16254 | Number of tests: 6 01:08:55 INFO - PROCESS | 16254 | 01:08:55 INFO - PROCESS | 16254 | [#0] dojo.html Cycles:165 Average:4758.45 Median:4837.23 stddev:504.67 (10.4%) stddev-sans-first:477.72 01:08:55 INFO - PROCESS | 16254 | Values: 2627.1 2643.7 2666.8 2688.4 2692.7 4684.7 4728.3 4752.1 4803.7 4871.9 4772.6 4809.1 4820.1 4825.4 4879.4 4332.1 4400.9 4477.4 4534.3 4536.4 4463.9 4497.8 4505.2 4511.8 4536.4 4330.7 4344.9 4367.7 4371.8 4410.4 4361.9 4372.1 4374.0 4412.5 4421.3 4398.3 4403.4 4410.9 4448.9 4466.3 4681.2 4731.1 4762.4 4775.4 4798.1 5165.9 5201.0 5214.3 5216.7 5230.6 5211.2 5251.1 5258.2 5261.6 5263.7 4679.3 4786.8 4814.8 4823.1 4881.7 5327.2 5353.4 5355.1 5357.6 5360.1 4896.8 5106.0 5138.4 5152.1 5158.1 5145.2 5169.3 5175.2 5205.8 5219.2 5155.3 5161.1 5180.6 5180.6 5228.8 4954.3 5062.8 5130.2 5141.5 5145.6 4407.1 4411.9 4417.6 4463.0 4475.3 3833.1 3837.9 3843.2 3866.6 3879.9 4348.8 4390.4 4447.8 4493.6 4500.1 5125.0 5132.8 5173.6 5181.2 5203.3 4443.9 4448.8 4455.9 4463.4 4492.7 4581.3 4581.6 4582.2 4680.2 4715.4 4766.0 4787.0 4799.7 4837.2 4842.3 5133.8 5143.8 5149.3 5149.3 5150.0 4648.3 4781.3 4783.6 4801.1 4809.3 5101.5 5113.9 5147.5 5147.8 5189.1 5166.3 5186.4 5190.1 5199.6 5200.4 4910.8 4976.4 5058.2 5064.9 5091.1 4886.1 4887.6 4892.5 4903.5 4932.8 4819.6 4831.0 4840.1 4883.7 4889.6 4932.1 4978.3 4999.5 5000.0 5019.6 4943.3 4953.5 4957.2 4958.1 5005.9 01:08:55 INFO - PROCESS | 16254 | 01:08:55 INFO - PROCESS | 16254 | [#1] ext.html Cycles:180 Average:43693.68 Median:37653.12 stddev:75801.52 (201.3%) stddev-sans-first:75945.03 01:08:55 INFO - PROCESS | 16254 | Values: 573.9 576.0 578.3 597.8 605.0 29388.9 39170.0 41334.8 41396.8 44836.8 41538.2 41926.2 42098.8 42111.0 42167.0 7761.8 7903.8 7905.6 7909.2 7914.2 7692.2 7766.1 7779.0 7779.9 7783.1 7815.7 7872.6 7873.9 7874.4 7876.3 7777.5 7800.2 7817.5 7820.3 7822.8 7569.4 7635.7 7643.7 7643.9 7644.2 39170.8 39369.4 39435.6 39532.0 39609.2 2870.4 3078.3 3254.7 3584.9 3680.1 27607.9 28933.6 30864.2 30955.7 30958.1 3452.1 3551.2 3587.3 3633.9 3673.2 109287.5 110029.0 110099.0 110460.0 110789.0 51205.7 57613.7 59104.0 60203.4 60370.0 57843.4 58165.4 58199.4 58288.4 58343.4 15280.2 15528.7 15550.5 15576.9 15581.5 10691.7 10907.8 11663.8 11739.2 11808.0 16761.8 18720.3 19310.8 20242.4 20438.0 7252.7 7335.8 7366.3 7427.7 7692.0 821.9 841.2 875.8 898.8 991.2 28395.1 28700.4 28940.3 29422.6 29739.4 926.2 928.9 964.8 1006.3 1008.7 13961.9 14715.5 14811.0 14839.9 14919.3 367463.0 370498.0 371900.0 372593.0 372933.0 50240.0 50952.5 50982.2 51017.7 51102.7 1070.7 1128.5 1164.9 1187.7 1235.4 28156.7 29418.3 29531.0 30156.5 30205.2 43411.8 44237.6 44294.3 44349.6 44384.0 306171.0 309387.0 310141.0 310309.0 310706.0 25837.9 27525.6 28476.1 28675.1 28846.3 43616.6 43644.8 43658.6 44663.3 44688.3 37098.4 37380.6 37508.6 37651.0 38633.0 37037.3 37842.2 37902.0 38025.8 38090.8 36576.8 37227.1 37599.6 37655.2 37885.0 33173.8 33405.8 33891.5 35268.8 35537.8 25914.5 25980.4 26123.6 26230.6 26289.7 01:08:55 INFO - PROCESS | 16254 | 01:08:55 INFO - PROCESS | 16254 | [#2] jquery.html Cycles:180 Average:25036.58 Median:4917.19 stddev:68398.41 (1391.0%) stddev-sans-first:68565.18 01:08:55 INFO - PROCESS | 16254 | Values: 354.9 356.5 356.7 365.3 372.7 16054.5 17156.9 17507.7 17507.9 17552.3 16327.3 16902.3 17310.7 17330.7 17342.7 4865.8 5095.5 5098.8 5124.5 5138.6 3691.1 3911.9 5080.5 5755.3 6076.9 6093.8 6094.8 6140.0 6141.3 6144.1 5838.2 6086.8 6090.9 6094.8 6110.2 3246.4 4968.6 5283.7 5289.1 5296.7 19739.6 20421.1 20448.7 20678.1 20719.7 1995.4 2174.3 2335.8 2582.2 2606.9 12565.5 13298.4 13404.8 13613.8 13918.3 1744.8 1817.2 1867.4 1867.8 1876.6 68176.0 68354.0 68826.3 68900.0 69936.3 9327.2 9333.5 9605.3 9607.8 9784.6 13019.9 13084.1 13100.5 13133.1 13146.1 6955.1 6974.5 7021.6 7036.2 7161.4 6687.0 6715.7 6873.4 6876.5 6891.0 6022.2 6090.2 6094.5 6102.4 6170.6 1576.9 1635.0 1701.1 1701.8 1741.1 824.8 851.0 884.9 898.6 946.8 16461.8 16568.5 16755.9 17204.6 17580.1 870.1 881.5 908.4 923.4 929.8 9790.6 9906.8 9980.6 9981.6 10099.9 406651.0 409234.0 412766.0 423949.0 428268.0 64364.4 67870.3 68538.3 68824.0 69235.0 891.8 896.5 948.2 948.7 949.9 15397.5 15676.6 15738.4 15740.5 16017.4 38535.8 38634.8 38836.8 39059.4 39128.8 52779.7 54139.2 54173.0 54238.6 54271.0 7199.2 7444.3 7560.7 7660.0 7740.7 10766.6 11532.7 11703.8 11850.5 11855.2 10101.7 10211.9 10426.6 10435.8 10440.5 9800.5 10302.3 10322.4 10591.0 10611.9 10603.5 10631.3 10868.5 10880.7 10970.9 6478.2 6701.2 6837.6 7057.4 7629.4 7276.4 8853.6 9769.0 10398.7 10520.0 01:08:55 INFO - PROCESS | 16254 | 01:08:55 INFO - PROCESS | 16254 | [#3] mootools.html Cycles:180 Average:4995.07 Median:5001.75 stddev:2840.02 (56.8%) stddev-sans-first:2833.79 01:08:55 INFO - PROCESS | 16254 | Values: 1216.2 1322.8 1363.9 1412.3 1648.7 6600.5 7370.9 7655.8 7659.0 7850.1 7605.1 7742.6 7766.0 7767.2 7768.2 1844.2 2039.6 2093.3 2098.7 2131.0 2168.6 2175.7 2179.6 2181.9 2183.0 2074.5 2089.5 2144.3 2145.0 2147.7 1774.1 1975.0 2039.1 2045.3 2097.1 2080.8 2087.0 2088.6 2091.3 2091.6 7581.2 7652.4 7691.7 7692.5 7694.5 4235.9 4335.8 4348.5 4452.0 4471.2 2649.5 2728.2 2739.4 2740.6 2741.8 860.5 887.7 906.3 911.9 913.5 10366.4 10422.9 10427.6 10429.4 10432.3 3922.1 3968.5 4012.9 4032.3 4136.3 8811.6 8813.3 8814.4 8824.6 8825.6 4574.2 4596.1 4598.2 4598.5 4601.6 3535.6 4074.7 4177.5 4219.8 4257.4 3536.8 3554.3 3561.8 3653.9 3670.8 1147.0 1151.3 1155.9 1164.5 1166.6 822.2 843.1 866.8 870.6 870.7 4982.4 5021.1 5142.0 5261.5 5356.8 386.5 388.4 390.1 392.3 394.6 3549.4 3595.4 3606.0 3606.9 3647.3 9023.3 9452.5 9508.4 9520.2 9561.8 9467.1 9468.5 9472.9 9481.3 9482.2 6786.7 6858.2 6978.7 7017.7 7037.5 5037.4 5074.3 5085.3 5109.3 5160.5 8694.6 8707.5 8729.0 8752.6 8805.5 8658.8 8962.6 8966.8 8974.0 8986.9 5880.6 6085.3 6089.6 6612.2 6681.0 6545.2 6707.5 7395.6 7410.1 7563.8 6653.4 6752.2 6755.5 6838.8 6852.9 6465.2 6467.5 6506.6 6516.2 6574.4 6342.8 6367.5 6373.9 6398.8 6409.4 4395.4 4515.5 4541.8 4570.0 4570.1 4391.1 4412.4 4413.3 4475.1 4477.1 01:08:55 INFO - PROCESS | 16254 | 01:08:55 INFO - PROCESS | 16254 | [#4] prototype.html Cycles:180 Average:4203.10 Median:4841.28 stddev:1239.50 (25.6%) stddev-sans-first:1207.57 01:08:55 INFO - PROCESS | 16254 | Values: 283.7 286.7 292.0 301.5 303.6 4816.6 4843.6 4849.2 4857.0 4914.2 4787.5 4829.3 4832.6 4839.0 4849.8 3616.5 3707.3 3717.7 3727.2 3732.2 3670.8 3736.9 3811.5 3813.6 3813.9 3737.8 3753.8 3761.6 3762.3 3783.2 3548.3 3726.9 3760.9 3762.9 3768.2 3238.3 3246.2 3249.6 3249.8 3253.5 4741.3 4749.8 4750.4 4751.4 4774.4 4113.0 4243.9 4265.7 4274.3 4305.6 4936.5 4992.5 5017.8 5026.8 5031.4 3563.5 3584.2 3586.5 3593.8 3601.0 5169.9 5262.1 5286.0 5332.3 5350.2 3573.6 3610.5 3615.8 3626.3 3629.9 3646.6 3649.2 3652.9 3653.5 3656.7 4212.9 4217.6 4221.8 4242.6 4246.2 4860.9 5126.8 5129.6 5132.2 5138.5 1276.9 1290.2 1294.4 1294.5 1298.4 791.5 795.9 814.8 823.2 825.2 4358.3 4484.1 4488.0 4524.5 4532.8 5252.3 5261.3 5266.4 5297.6 5299.5 4448.3 4451.3 4455.2 4461.8 4526.5 2622.5 2767.7 2768.3 2794.4 2802.0 4891.6 4905.6 4907.5 4918.2 4937.2 5170.5 5283.5 5317.4 5369.2 5392.5 4882.1 4895.6 4899.9 4902.3 4905.5 5215.6 5225.9 5245.9 5259.2 5284.5 4869.4 5122.4 5126.9 5127.9 5165.6 4824.6 4867.2 4884.9 4915.3 4931.9 3632.5 3661.9 3697.5 3699.6 3706.3 5144.5 5214.7 5287.7 5292.0 5304.3 5068.4 5068.5 5099.8 5141.8 5149.6 5116.1 5138.8 5141.8 5166.3 5176.2 4870.2 5050.4 5052.9 5054.9 5062.3 4921.6 5048.3 5136.7 5150.5 5182.0 4984.4 5008.7 5015.0 5052.5 5059.9 01:08:55 INFO - PROCESS | 16254 | 01:08:55 INFO - PROCESS | 16254 | [#5] yui.html Cycles:180 Average:17262.31 Median:24355.23 stddev:24150.17 (99.2%) stddev-sans-first:24185.63 01:08:55 INFO - PROCESS | 16254 | Values: 631.6 642.5 645.7 725.9 739.5 12369.6 13085.7 13162.3 13167.5 13188.7 12299.0 12308.4 12332.8 12448.5 12902.1 615.0 755.6 783.4 799.0 801.5 789.6 802.1 802.1 803.2 804.3 842.2 842.9 844.9 845.4 846.4 638.4 788.2 823.7 830.8 832.1 608.5 608.7 609.0 609.4 611.2 12737.8 12787.4 12807.6 12822.7 12828.2 11061.3 12417.3 12700.7 12892.4 13106.1 11404.2 11621.4 11745.4 11813.6 12093.6 4047.8 4081.8 4177.0 4253.8 4254.9 66001.7 66665.0 66882.3 67649.7 68816.0 10193.3 10262.6 10265.4 10276.2 10626.7 16013.3 16191.3 16236.8 16820.0 17749.6 7079.9 7091.9 7160.5 7160.8 7234.3 3645.0 3645.3 3775.1 3777.2 3816.3 2834.1 2965.5 2965.7 2967.4 2969.7 488.3 488.5 501.0 505.4 505.5 457.5 579.9 606.4 612.9 634.1 8331.6 8510.1 8535.0 8645.0 8663.9 592.3 604.8 608.1 609.0 615.3 3926.0 4088.2 4092.8 4127.1 4273.0 92092.0 92099.0 93367.0 97873.0 97913.0 48253.0 63980.7 78102.6 78220.2 78560.6 45457.3 72048.0 73178.0 73543.9 75862.0 7600.8 7709.6 7826.0 7947.3 8043.2 42714.4 43871.6 45142.0 45166.0 45198.8 61950.4 63915.0 64377.0 64904.4 65045.7 9658.2 9981.1 9996.9 10109.2 11081.4 12137.6 12652.5 12704.0 13174.3 13851.7 11631.4 11911.9 12322.4 12378.3 12475.2 11900.1 11922.5 11946.8 12145.0 12198.4 11492.8 11884.2 12068.5 12170.5 12362.9 9577.2 9714.3 9932.5 10047.3 10367.6 10369.4 10405.9 10427.8 10773.7 10897.1 01:08:55 INFO - PROCESS | 16254 | -------- Summary: end -------- 01:08:55 INFO - PROCESS | 16254 | 01:08:56 INFO - TEST-INFO | 16254: exit 0 01:08:56 INFO - TEST-OK | dromaeo_css | took 1119114ms 01:08:56 INFO - TEST-START | kraken 01:08:56 INFO - operating with platform_type : linux_ 01:08:56 INFO - Initialising browser for kraken test... 01:08:56 INFO - TEST-INFO | started process 16434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdKDNS/profile http://localhost:45371/getInfo.html) 01:09:00 INFO - PROCESS | 16434 | __metrics Screen width/height:1600/1200 01:09:00 INFO - PROCESS | 16434 | colorDepth:24 01:09:00 INFO - PROCESS | 16434 | Browser inner width/height: 1024/697 01:09:00 INFO - PROCESS | 16434 | __metrics 01:09:01 INFO - PROCESS | 16434 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:09:02 INFO - TEST-INFO | 16434: exit 0 01:09:02 INFO - Browser initialized. 01:09:02 INFO - Running cycle 1/1 for kraken test... 01:09:02 INFO - TEST-INFO | started process 16515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdKDNS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:14 INFO - PROCESS | 16515 | RSS: Main: 158949376 01:09:14 INFO - PROCESS | 16515 | 01:09:17 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45371/tests/kraken/driver.html?testName=audio-beat-detection) 01:09:17 INFO - PROCESS | 16515 | RSS: Main: 216580096 01:09:17 INFO - PROCESS | 16515 | 01:09:20 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45371/tests/kraken/driver.html?testName=audio-dft) 01:09:21 INFO - PROCESS | 16515 | RSS: Main: 204910592 01:09:21 INFO - PROCESS | 16515 | 01:09:24 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45371/tests/kraken/driver.html?testName=audio-fft) 01:09:25 INFO - PROCESS | 16515 | RSS: Main: 271220736 01:09:25 INFO - PROCESS | 16515 | 01:09:27 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45371/tests/kraken/driver.html?testName=audio-oscillator) 01:09:28 INFO - PROCESS | 16515 | RSS: Main: 180908032 01:09:28 INFO - PROCESS | 16515 | 01:09:30 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45371/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:09:30 INFO - PROCESS | 16515 | RSS: Main: 185032704 01:09:30 INFO - PROCESS | 16515 | 01:09:34 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45371/tests/kraken/driver.html?testName=imaging-darkroom) 01:09:34 INFO - PROCESS | 16515 | RSS: Main: 221323264 01:09:34 INFO - PROCESS | 16515 | 01:09:38 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45371/tests/kraken/driver.html?testName=imaging-desaturate) 01:09:38 INFO - PROCESS | 16515 | RSS: Main: 222150656 01:09:38 INFO - PROCESS | 16515 | 01:09:41 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45371/tests/kraken/driver.html?testName=json-parse-financial) 01:09:42 INFO - PROCESS | 16515 | RSS: Main: 221794304 01:09:42 INFO - PROCESS | 16515 | 01:09:43 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45371/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:09:44 INFO - PROCESS | 16515 | RSS: Main: 211079168 01:09:44 INFO - PROCESS | 16515 | 01:09:46 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45371/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:09:47 INFO - PROCESS | 16515 | RSS: Main: 216678400 01:09:47 INFO - PROCESS | 16515 | 01:09:49 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45371/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:09:49 INFO - PROCESS | 16515 | RSS: Main: 222515200 01:09:50 INFO - PROCESS | 16515 | 01:09:52 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:09:53 INFO - PROCESS | 16515 | RSS: Main: 223100928 01:09:53 INFO - PROCESS | 16515 | 01:09:56 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:09:56 INFO - PROCESS | 16515 | RSS: Main: 222650368 01:09:56 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | Cycle 1(1): loaded http://localhost:45371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45371/tests/kraken/driver.html?testName=ai-astar) 01:09:58 INFO - PROCESS | 16515 | RSS: Main: 265273344 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | __start_tp_report 01:09:58 INFO - PROCESS | 16515 | _x_x_mozilla_page_load 01:09:58 INFO - PROCESS | 16515 | _x_x_mozilla_page_load_details 01:09:58 INFO - PROCESS | 16515 | |i|pagename|runs| 01:09:58 INFO - PROCESS | 16515 | |0;ai-astar;104;114;112;113;113;111;112;112;113;111 01:09:58 INFO - PROCESS | 16515 | |1;audio-beat-detection;159;136;135;194;135;158;154;134;184;133 01:09:58 INFO - PROCESS | 16515 | |2;audio-dft;162;162;161;160;164;161;161;162;163;160 01:09:58 INFO - PROCESS | 16515 | |3;audio-fft;76;76;77;118;77;77;77;75;97;76 01:09:58 INFO - PROCESS | 16515 | |4;audio-oscillator;86;86;119;86;87;86;130;88;86;129 01:09:58 INFO - PROCESS | 16515 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;116 01:09:58 INFO - PROCESS | 16515 | |6;imaging-darkroom;147;147;146;147;147;147;146;146;146;147 01:09:58 INFO - PROCESS | 16515 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;94;95 01:09:58 INFO - PROCESS | 16515 | |8;json-parse-financial;64;63;64;63;64;65;64;63;64;64 01:09:58 INFO - PROCESS | 16515 | |9;json-stringify-tinderbox;65;65;65;65;65;66;65;65;66;65 01:09:58 INFO - PROCESS | 16515 | |10;stanford-crypto-aes;88;84;87;82;81;82;90;86;108;83 01:09:58 INFO - PROCESS | 16515 | |11;stanford-crypto-ccm;131;138;141;127;129;130;129;127;132;138 01:09:58 INFO - PROCESS | 16515 | |12;stanford-crypto-pbkdf2;164;166;169;165;168;165;181;163;163;162 01:09:58 INFO - PROCESS | 16515 | |13;stanford-crypto-sha256-iterative;71;68;69;65;70;66;66;66;66;65 01:09:58 INFO - PROCESS | 16515 | __end_tp_report 01:09:58 INFO - PROCESS | 16515 | __start_cc_report 01:09:58 INFO - PROCESS | 16515 | _x_x_mozilla_cycle_collect,1895 01:09:58 INFO - PROCESS | 16515 | __end_cc_report 01:09:58 INFO - PROCESS | 16515 | __startTimestamp1467187798777__endTimestamp 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | ------- Summary: start ------- 01:09:58 INFO - PROCESS | 16515 | Number of tests: 14 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 01:09:58 INFO - PROCESS | 16515 | Values: 104.0 114.0 112.0 113.0 113.0 111.0 112.0 112.0 113.0 111.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:156.00 stddev:22.10 (14.2%) stddev-sans-first:23.30 01:09:58 INFO - PROCESS | 16515 | Values: 159.0 136.0 135.0 194.0 135.0 158.0 154.0 134.0 184.0 133.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 01:09:58 INFO - PROCESS | 16515 | Values: 162.0 162.0 161.0 160.0 164.0 161.0 161.0 162.0 163.0 160.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:14.04 (18.2%) stddev-sans-first:14.69 01:09:58 INFO - PROCESS | 16515 | Values: 76.0 76.0 77.0 118.0 77.0 77.0 77.0 75.0 97.0 76.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:86.00 stddev:19.34 (22.5%) stddev-sans-first:19.99 01:09:58 INFO - PROCESS | 16515 | Values: 86.0 86.0 119.0 86.0 87.0 86.0 130.0 88.0 86.0 129.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 01:09:58 INFO - PROCESS | 16515 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:09:58 INFO - PROCESS | 16515 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 147.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 01:09:58 INFO - PROCESS | 16515 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 01:09:58 INFO - PROCESS | 16515 | Values: 64.0 63.0 64.0 63.0 64.0 65.0 64.0 63.0 64.0 64.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 01:09:58 INFO - PROCESS | 16515 | Values: 65.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 65.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.00 stddev:7.91 (9.3%) stddev-sans-first:8.38 01:09:58 INFO - PROCESS | 16515 | Values: 88.0 84.0 87.0 82.0 81.0 82.0 90.0 86.0 108.0 83.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:131.50 stddev:5.01 (3.8%) stddev-sans-first:5.29 01:09:58 INFO - PROCESS | 16515 | Values: 131.0 138.0 141.0 127.0 129.0 130.0 129.0 127.0 132.0 138.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:165.50 stddev:5.52 (3.3%) stddev-sans-first:5.78 01:09:58 INFO - PROCESS | 16515 | Values: 164.0 166.0 169.0 165.0 168.0 165.0 181.0 163.0 163.0 162.0 01:09:58 INFO - PROCESS | 16515 | 01:09:58 INFO - PROCESS | 16515 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:2.15 (3.2%) stddev-sans-first:1.79 01:09:58 INFO - PROCESS | 16515 | Values: 71.0 68.0 69.0 65.0 70.0 66.0 66.0 66.0 66.0 65.0 01:09:58 INFO - PROCESS | 16515 | -------- Summary: end -------- 01:09:58 INFO - PROCESS | 16515 | 01:09:59 INFO - TEST-INFO | 16515: exit 0 01:09:59 INFO - TEST-OK | kraken | took 63392ms 01:09:59 INFO - SUITE-END | took 1182s 01:09:59 INFO - Completed test suite (00:19:42) 01:09:59 INFO - javascript benchmark 01:09:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.146177492315, 2643.6563246777914, 2666.8133230673848, 2688.4354285600034, 2692.6634170728657, 4684.695494792836, 4728.267118596618, 4752.097101550703, 4803.711777293365, 4871.902561948763, 4772.642051846116, 4809.086273608012, 4820.060088282787, 4825.445073816512, 4879.414470263565, 4332.06860524987, 4400.911981760363, 4477.395551600524, 4534.34252033455, 4536.364908912755, 4463.910721785563, 4497.797599108032, 4505.166544189319, 4511.751853648048, 4536.410266665345, 4330.740155590644, 4344.91310173798, 4367.71609845359, 4371.78141092944, 4410.382546443484, 4361.912761744779, 4372.147431250907, 4374.03771170342, 4412.492563355191, 4421.336799480072, 4398.296272596402, 4403.383526306319, 4410.933835992462, 4448.911021779546, 4466.307722303049, 4681.204195286809, 4731.124741922756, 4762.38089048425, 4775.426948766136, 4798.1123492154065, 5165.9225111623355, 5201.0, 5214.270002199695, 5216.713080780555, 5230.581553475713, 5211.1922651989, 5251.054810134175, 5258.237555554423, 5261.552768014685, 5263.6578622389425, 4679.274712419615, 4786.7845946932475, 4814.7833347499445, 4823.083614113307, 4881.731504767201, 5327.174287985291, 5353.357597088297, 5355.143177091647, 5357.624966252403, 5360.115580929181, 4896.755162241873, 5106.0, 5138.409082955508, 5152.149895267239, 5158.097332966716, 5145.22821576759, 5169.25045868347, 5175.249588809602, 5205.817796377184, 5219.164933610604, 5155.278261043457, 5161.096808058574, 5180.585553155738, 5180.637355385087, 5228.790848366023, 4954.281629163823, 5062.848114556569, 5130.230465430215, 5141.460146684619, 5145.614078944094, 4407.0524837160165, 4411.911761764747, 4417.602415782595, 4463.04044630406, 4475.30632751924, 3833.0609000794984, 3837.9424308635394, 3843.2313537292653, 3866.5553461352306, 3879.9030024249055, 4348.760818155032, 4390.407295015196, 4447.844325448594, 4493.573110554492, 4500.099980004013, 5125.0, 5132.794688212504, 5173.560247379015, 5181.1969144782615, 5203.323567936144, 4443.911121777611, 4448.844290449883, 4455.866324010285, 4463.366474517438, 4492.707973981681, 4581.335706322565, 4581.5647513486165, 4582.152301824173, 4680.180968330528, 4715.434147902273, 4765.9523404765505, 4787.0, 4799.736014519095, 4837.22604383304, 4842.346283251716, 5133.845984620468, 5143.794248230029, 5149.304843846033, 5149.304843846033, 5150.0, 4648.3027545867035, 4781.306710527024, 4783.617310615212, 4801.135795556694, 4809.278608208797, 5101.540861322499, 5113.8721531962, 5147.485251474823, 5147.794088236578, 5189.117849965591, 5166.2767212589515, 5186.377634683711, 5190.117679994334, 5199.636025478331, 5200.375954885438, 4910.8281210157475, 4976.353074100344, 5058.190689489664, 5064.924026139537, 5091.109055915126, 4886.096072226649, 4887.633427492881, 4892.535209155125, 4903.460619331942, 4932.802687892444, 4819.638527110411, 4830.9854930465, 4840.056189043244, 4883.731394773322, 4889.608831293559, 4932.136876046606, 4978.253262010582, 4999.500049994971, 5000.024995125916, 5019.623528235324, 4943.2585112233455, 4953.455119936876, 4957.206846904478, 4958.1323268428605, 5005.949940500548], "value": 4725.812776922161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.8766165274466, 575.985600359991, 578.3291381996885, 597.8087012156112, 604.9909251361233, 29388.85305573472, 39170.0, 41334.79332603333, 41396.79301603495, 44836.77581612088, 41538.16923661525, 41926.161476770445, 42098.789506052504, 42111.0, 42167.0, 7761.844763104735, 7903.762887113396, 7905.565193914361, 7909.24862138096, 7914.208579142069, 7692.153863075086, 7766.068071831388, 7779.0, 7779.922200777976, 7783.104942931551, 7815.687372505093, 7872.645730942093, 7873.881891771628, 7874.448788584801, 7876.251756083191, 7777.494462859924, 7800.18098099697, 7817.452778305521, 7820.257075577811, 7822.765317040498, 7569.356604688553, 7635.656395462218, 7643.656035478417, 7643.923560764377, 7644.159142494321, 39170.804145979375, 39369.40945885814, 39435.60564394348, 39532.0, 39609.207815843525, 2870.354170311684, 3078.2612173078523, 3254.723348515355, 3584.874529391459, 3680.0799800049986, 27607.86196069027, 28933.56599650986, 30864.228394290323, 30955.690443095507, 30958.0712578623, 3452.1369657585606, 3551.200979779555, 3587.3184095022125, 3633.9273214535824, 3673.210259794157, 109287.45356273168, 110029.0, 110099.0, 110460.0, 110789.0, 51205.7439712799, 57613.71193144008, 59104.0, 60203.39796602065, 60370.0, 57843.42156578464, 58165.41834581685, 58199.4180058194, 58288.4171158283, 58343.416565833795, 15280.159591222367, 15528.689426211413, 15550.533483995498, 15576.922115389578, 15581.454649087227, 10691.679249622524, 10907.83638245427, 11663.825042624367, 11739.178257521891, 11808.0, 16761.83238167627, 18720.25118995225, 19310.80701512334, 20242.3806095512, 20438.0, 7252.709891604382, 7335.816604584928, 7366.263373662591, 7427.665755041036, 7692.0, 821.9178082191733, 841.2344766262671, 875.7504111328241, 898.797770501645, 991.1674193677345, 28395.148145555668, 28700.425991480053, 28940.27649308784, 29422.558661620093, 29739.405211895642, 926.1988380051207, 928.8978212396631, 964.7925695975399, 1006.3257617396362, 1008.6613309944108, 13961.930190348983, 14715.484958026418, 14811.033689823833, 14839.851601483848, 14919.254037298091, 367463.0, 370498.0, 371900.0, 372593.0, 372933.0, 50240.0, 50952.490475094775, 50982.235266471034, 51017.74491127521, 51102.744486278076, 1070.71626019105, 1128.514738662383, 1164.8776878427982, 1187.6674531131298, 1235.3576140407117, 28156.71843281623, 29418.26454338573, 29531.0, 30156.54765178568, 30205.244868878453, 43411.78294108509, 44237.557624423345, 44294.335584966895, 44349.55650443583, 44384.0, 306171.0, 309387.0, 310141.0, 310309.0, 310706.0, 25837.89945206587, 27525.587116193674, 28476.145715628565, 28675.13974580766, 28846.278843029093, 43616.56383436125, 43644.78177609092, 43658.56341436672, 44663.33005004862, 44688.32967505555, 37098.44352334663, 37380.62619373771, 37508.624913750515, 37651.0, 38633.0, 37037.25925481529, 37842.243155136195, 37902.0, 38025.80987095047, 38090.80954595209, 36576.81711591425, 37227.06932326713, 37599.624003759614, 37655.24689506249, 37885.0, 33173.83413082919, 33405.83297083499, 33891.49162762511, 35268.823655881555, 35537.82231088828, 25914.481710366064, 25980.35049123787, 26123.608145877446, 26230.606540902285, 26289.73710262873], "value": 17582.380745321712, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.9290141971606, 356.5400633183192, 356.6665168067856, 365.2749292654083, 372.68135743938933, 16054.51836444907, 17156.914215428922, 17507.73738393925, 17507.91246043771, 17552.297908083663, 16327.34690612377, 16902.323907043734, 17310.653786924253, 17330.74003889943, 17342.739858902125, 4865.805367785284, 5095.464976177485, 5098.847034588968, 5124.487551244864, 5138.563222126124, 3691.095681558022, 3911.9413208801748, 5080.491950804909, 5755.280589926259, 6076.939230607703, 6093.847653808646, 6094.847628809271, 6140.048292514667, 6141.324454310023, 6144.078388241777, 5838.153467747175, 6086.756529738849, 6090.939090609104, 6094.847628809271, 6110.236220472441, 3246.4318744219668, 4968.577670897978, 5283.682979021232, 5289.127293996486, 5296.655717378358, 19739.605207895762, 20421.081051352576, 20448.693269600968, 20678.069486872977, 20719.689204661943, 1995.4013795861183, 2174.3368272676985, 2335.801456876168, 2582.1995181493608, 2606.9217923462325, 12565.497380104785, 13298.40157192919, 13404.798928016087, 13613.795793063113, 13918.30408479572, 1744.8080711121765, 1817.155022914338, 1867.4304337177155, 1867.7945426003264, 1876.5965317456812, 68176.0, 68353.97469038019, 68826.31173688249, 68900.0, 69936.30063699349, 9327.207187389013, 9333.486658233862, 9605.327627066177, 9607.759806004766, 9784.608615655436, 13019.869801302055, 13084.149530280501, 13100.541481048118, 13133.080684352195, 13146.079774415699, 6955.130608673916, 6974.476914231352, 7021.613811240431, 7036.155661320674, 7161.39128174111, 6686.96656516724, 6715.731370745213, 6873.415759660485, 6876.484263680244, 6891.036854152662, 6022.1870047543025, 6090.23872015998, 6094.481969032593, 6102.389761023951, 6170.56806023583, 1576.8501992310712, 1634.9781386633354, 1701.072915261161, 1701.8128005919586, 1741.0685283373334, 824.8474032304043, 850.9702160424356, 884.9159329863653, 898.6270697660528, 946.8201041802173, 16461.83538164603, 16568.502944911674, 16755.916220419065, 17204.569885752706, 17580.12099395025, 870.0994470722771, 881.5151666583354, 908.3913777768779, 923.35826600512, 929.7907970706672, 9790.5594248259, 9906.80186396268, 9980.550875210633, 9981.550830212658, 10099.949500252598, 406651.0, 409234.0, 412766.0, 423949.0, 428268.0, 64364.35635643677, 67870.32129678738, 68538.31461685419, 68824.0, 69235.0, 891.8216356728681, 896.5248418338291, 948.1514044929887, 948.6584829461389, 949.8717673114179, 15397.461088861835, 15676.608084797972, 15738.370465181264, 15740.527784166494, 16017.35930562811, 38535.80732096321, 38634.806825965694, 38836.805815970736, 39059.41410878782, 39128.804355978034, 52779.73610131925, 54139.18791218056, 54173.0, 54238.64403389789, 54271.0, 7199.2440793715905, 7444.255574442513, 7560.659770310459, 7660.0, 7740.651670674946, 10766.623168189075, 11532.654020379403, 11703.76592468129, 11850.525978960744, 11855.229410088317, 10101.69694909154, 10211.948940255252, 10426.635067772591, 10435.843462348223, 10440.477976101316, 9800.460974646177, 10302.33034852732, 10322.380657160595, 10590.993855583707, 10611.946940265248, 10603.469826508797, 10631.255812093079, 10868.456577171268, 10880.67357979262, 10970.890291097307, 6478.222613286436, 6701.195856497252, 6837.62393068386, 7057.36483716468, 7629.351505122127, 7276.381507571704, 8853.557322133738, 9768.951155244178, 10398.74003149897, 10520.0], "value": 8379.812019751836, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1216.1547724331592, 1322.8478724946633, 1363.8704323089305, 1412.329143656763, 1648.6867495175916, 6600.471962243021, 7370.852582948344, 7655.770326890195, 7659.0, 7850.136484986647, 7605.125410577785, 7742.574158421285, 7766.0, 7767.184445633212, 7768.223177682229, 1844.1701234444486, 2039.612473630013, 2093.3405977117236, 2098.7061811346384, 2130.9680354794614, 2168.56628674265, 2175.7497887742875, 2179.6294629912954, 2181.945451363713, 2183.0285522942295, 2074.543600407908, 2089.4985203551114, 2144.3245377706053, 2145.0454547726267, 2147.699322094908, 1774.0952114421673, 1974.9506262343557, 2039.1129858511595, 2045.3148195354574, 2097.056324653904, 2080.8023237792386, 2086.968695469569, 2088.571842772228, 2091.309867743656, 2091.623507768601, 7581.2418758124295, 7652.426068044863, 7691.692332306701, 7692.538447693157, 7694.499857509244, 4235.894102647428, 4335.8048887799805, 4348.499922508889, 4451.9777401113115, 4471.217536931056, 2649.523085844547, 2728.181545536351, 2739.4384151248946, 2740.6026126211787, 2741.7943654225814, 860.5439117267858, 887.6582515731425, 906.3202598051462, 911.9498427586481, 913.5021413329752, 10366.429846358447, 10422.9478852606, 10427.582896684124, 10429.374237545695, 10432.32189907661, 3922.117523557177, 3968.464257325282, 4012.8996775080273, 4032.334664780278, 4136.276151673445, 8811.603477843513, 8813.338999575057, 8814.382993190544, 8824.602892869836, 8825.646974121091, 4574.199515084913, 4596.126735920231, 4598.172328980749, 4598.517155698671, 4601.585857272861, 3535.611082780892, 4074.7351422157467, 4177.456930599003, 4219.767912764827, 4257.4252475915355, 3536.8054756988613, 3554.2713743682484, 3561.786292822387, 3653.8903832885057, 3670.834812433447, 1146.954121835134, 1151.2746969409386, 1155.930644161353, 1164.4992653159222, 1166.6383421139474, 822.2024636102971, 843.0641987393988, 866.8353012927649, 870.634333579898, 870.7387783664875, 4982.402111746614, 5021.096202683552, 5142.0, 5261.4738526147075, 5356.758945847446, 386.5207143142483, 388.40186113385636, 390.1397418691778, 392.3330338424689, 394.61327898659476, 3549.3611149992735, 3595.3708101082207, 3605.963940360563, 3606.9098272543397, 3647.2705458908326, 9023.323250756219, 9452.52737363129, 9508.429494230368, 9520.190783783317, 9561.808763824823, 9467.147956683793, 9468.479233642078, 9472.857907131398, 9481.288903332277, 9482.241420686329, 6786.710525000333, 6858.177018757781, 6978.720851165896, 7017.7192912282935, 7037.507374483737, 5037.395512538519, 5074.264231686311, 5085.288059671575, 5109.284700142058, 5160.509751573594, 8694.565271736261, 8707.521086340059, 8729.0, 8752.606132723915, 8805.51569663649, 8658.826823463369, 8962.641494340414, 8966.775830604287, 8974.0, 8986.910130898606, 5880.588358815013, 6085.3306136325855, 6089.599392139744, 6612.173478315211, 6681.031250468558, 6545.21457425112, 6707.496937729592, 7395.593242371721, 7410.110786705414, 7563.848723025619, 6653.434458071119, 6752.155980502437, 6755.527113102035, 6838.794836154923, 6852.897206542006, 6465.224173099258, 6467.482601391972, 6506.577072490273, 6516.185476815398, 6574.408303252731, 6342.778002769881, 6367.458766004941, 6373.936260637334, 6398.840028999312, 6409.359064093554, 4395.362672412546, 4515.548445155589, 4541.818327267005, 4570.040291538681, 4570.131674981742, 4391.077873646443, 4412.382266482759, 4413.337999300131, 4475.082608065273, 4477.1493416250805], "value": 3942.0454561281654, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.6596084698362, 286.6835965399571, 291.95766613840993, 301.5100461749657, 303.62805563185117, 4816.590589799866, 4843.612510999121, 4849.175640141176, 4857.0, 4914.238293064572, 4787.521247875211, 4829.251466022772, 4832.589229915461, 4838.951610483894, 4849.757512124388, 3616.4756110363915, 3707.2956138333766, 3717.721170912179, 3727.2172843702856, 3732.2348918471785, 3670.7614005089717, 3736.8505259789576, 3811.5235595550557, 3813.599572044937, 3813.9237215255816, 3737.8317975691025, 3753.7935413552245, 3761.5674197467233, 3762.322781899257, 3783.2004316805505, 3548.3258180945536, 3726.925461490755, 3760.905977350561, 3762.9059273518105, 3768.2275133597545, 3238.3037646906027, 3246.1722260823576, 3249.610046794376, 3249.772515923886, 3253.4957081652383, 4741.2651039089, 4749.810007599692, 4750.406199225097, 4751.40607424072, 4774.355462012619, 4113.0, 4243.875373026151, 4265.7014009019385, 4274.273373526508, 4305.63402110821, 4936.481669424695, 4992.450830408652, 5017.774200161001, 5026.84919452417, 5031.371078615173, 3563.467708885178, 3584.2258082249455, 3586.4620306953907, 3593.766405183681, 3601.0, 5169.922451163236, 5262.1319431602, 5285.973570132163, 5332.306800115999, 5350.217886698895, 3573.6426357364576, 3610.530631017951, 3615.8011309378235, 3626.3472574936236, 3629.94555081674, 3646.6171052039685, 3649.1789347397153, 3652.945205821915, 3653.5250417445563, 3656.6526180012856, 4212.85255016073, 4217.599328063829, 4221.767802770815, 4242.618164365222, 4246.214450326699, 4860.930595269035, 5126.79492820283, 5129.615278854101, 5132.204508301219, 5138.486151384906, 1276.8723127687158, 1290.1678417420899, 1294.4304506017322, 1294.5080869269618, 1298.441670081855, 791.5409062743595, 795.9442839001214, 814.8370325934836, 823.2261674026396, 825.195434451405, 4358.280883654162, 4484.080763443486, 4487.955120448819, 4524.547545245449, 4532.846897723555, 5252.345511164048, 5261.316378758837, 5266.3943646480375, 5297.576193904479, 5299.549538289211, 4448.288273876229, 4451.265541185733, 4455.175792478337, 4461.799219035086, 4526.479454862733, 2622.501724672306, 2767.6540432445945, 2768.269831355403, 2794.413173233603, 2802.047303916678, 4891.584215341664, 4905.607551395879, 4907.50321152052, 4918.213085906309, 4937.23472861707, 5170.515407418494, 5283.52448279649, 5317.361916570037, 5369.221462887859, 5392.514673679388, 4882.096812089775, 4895.608351331956, 4899.853004409873, 4902.313676085351, 4905.5094490550655, 5215.55667768244, 5225.92161117576, 5245.9475405246985, 5259.21111833228, 5284.497972692588, 4869.391326084239, 5122.436531981404, 5126.8974620508125, 5127.87180320495, 5165.61257905651, 4824.638152138534, 4867.245576935581, 4884.853454396374, 4915.26271059344, 4931.901361972812, 3632.4551317302617, 3661.8901432957055, 3697.4823524706026, 3699.5560532736245, 3706.314331848617, 5144.4855514449755, 5214.687118772886, 5287.709175995357, 5291.968066227048, 5304.257403963526, 5068.442471328225, 5068.543831055223, 5099.847004589868, 5141.817382002086, 5149.613778966517, 5116.083832215601, 5138.845834624967, 5141.820036298712, 5166.276721259102, 5176.249443830548, 4870.245112007645, 5050.444451110448, 5052.949470505395, 5054.949450505448, 5062.31658726082, 4921.646547199549, 5048.318477005557, 5136.686836990046, 5150.48495150482, 5182.0, 4984.37695288089, 5008.672701734116, 5015.0, 5052.494750525065, 5059.898802024012], "value": 3804.233928380398, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.5579094633756, 642.5245318464334, 645.6610279603204, 725.9346658800707, 739.5008369350688, 12369.567065152722, 13085.738285234289, 13162.341882905865, 13167.47330106797, 13188.736225275501, 12299.0, 12308.446119924602, 12332.753344933097, 12448.502059917593, 12902.096853220279, 614.9631022138686, 755.5919803306208, 783.4163548156631, 799.0451410564378, 801.5391150088693, 789.6328207383566, 802.0976401548259, 802.1136644008375, 803.1968031968032, 804.2600807257337, 842.2335674536173, 842.8819965204876, 844.8563744163507, 845.4251109245711, 846.4159729786459, 638.3520726462644, 788.1842293226483, 823.7322870067193, 830.8255266394034, 832.068083746205, 608.5283904973636, 608.6865264388844, 609.0103581679771, 609.4088733928082, 611.1840692675283, 12737.808932866015, 12787.424565894464, 12807.551735689207, 12822.679433014157, 12828.166169198972, 11061.336319820837, 12417.254964702057, 12700.682482937907, 12892.419841107172, 13106.082574219809, 11404.201705880592, 11621.360825154614, 11745.354005529693, 11813.586524471602, 12093.637190884288, 4047.7571345719352, 4081.8163182656854, 4177.039280965395, 4253.787310634487, 4254.914901701949, 66001.66999165021, 66665.0, 66882.33117668859, 67649.66175169093, 68816.0, 10193.286469947181, 10262.640807571699, 10265.384076955406, 10276.177905767521, 10626.681199564026, 16013.279402426919, 16191.271392787352, 16236.837631623768, 16820.0, 17749.55626109332, 7079.929200707927, 7091.89362159568, 7160.462965277625, 7160.785176444715, 7234.348908598146, 3644.9715937406454, 3645.2891686121484, 3775.075106598846, 3777.244551089793, 3816.31306364857, 2834.1214223590755, 2965.481040817848, 2965.724738362525, 2967.3768508613, 2969.6733359330456, 488.27003629573306, 488.5236894028294, 501.03800702651, 505.4036237240019, 505.49703045469994, 457.4510587295259, 579.9420057994167, 606.3663471672113, 612.9478994285447, 634.0932466572846, 8331.625076871554, 8510.148985101441, 8534.957325213334, 8645.0, 8663.870041949376, 592.2508027345411, 604.8246008657441, 608.1303735657963, 608.9878202436015, 615.3323643846387, 3926.0, 4088.1823635273063, 4092.7748973806133, 4127.112670775798, 4272.957270427256, 92092.0, 92099.0, 93367.0, 97873.0, 97913.0, 48253.0, 63980.68009660015, 78102.60948695334, 78220.21779782244, 78560.60719696365, 45457.31814022792, 72048.0, 73178.0, 73543.89684154742, 75862.0, 7600.771976840703, 7709.614519273901, 7825.960870195612, 7947.3244774194845, 8043.19568043191, 42714.35928461013, 43871.56128438675, 45142.0, 45166.0, 45198.774006131076, 61950.38049619627, 63915.0, 64377.0, 64904.350956489834, 65045.67477162584, 9658.179054780423, 9981.101700846668, 9996.900030999597, 10109.19126469866, 11081.39052352096, 12137.635870923887, 12652.510617037222, 12704.0, 13174.275414852274, 13851.65370865696, 11631.418429078682, 11911.931406770615, 12322.383880806103, 12378.319192444502, 12475.189112707645, 11900.107491937966, 11922.52309907594, 11946.76106477883, 12145.0, 12198.390080495763, 11492.770144596894, 11884.227525210834, 12068.456919438822, 12170.513179472722, 12362.876371236533, 9577.185939195246, 9714.271429642946, 9932.503374831374, 10047.296689231684, 10367.587175169489, 10369.377837329785, 10405.9479702601, 10427.791444170922, 10773.730656733644, 10897.073748731447], "value": 6573.508716299646, "unit": "score"}], "name": "dromaeo_css", "value": 6398.885759297672, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 112.0, 113.0, 113.0, 111.0, 112.0, 112.0, 113.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 136.0, 135.0, 194.0, 135.0, 158.0, 154.0, 134.0, 184.0, 133.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 164.0, 161.0, 161.0, 162.0, 163.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 118.0, 77.0, 77.0, 77.0, 75.0, 97.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 119.0, 86.0, 87.0, 86.0, 130.0, 88.0, 86.0, 129.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 64.0, 65.0, 64.0, 63.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 82.0, 81.0, 82.0, 90.0, 86.0, 108.0, 83.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 138.0, 141.0, 127.0, 129.0, 130.0, 129.0, 127.0, 132.0, 138.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 169.0, 165.0, 168.0, 165.0, 181.0, 163.0, 163.0, 162.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 69.0, 65.0, 70.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1546.4999999999998, "alertThreshold": 2.0}]} 01:10:00 INFO - Return code: 0 01:10:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:10:00 INFO - # TBPL SUCCESS # 01:10:00 INFO - Running post-action listener: _resource_record_post_action 01:10:00 INFO - ##### 01:10:00 INFO - ##### Finished run-tests step (success) 01:10:00 INFO - ##### 01:10:00 INFO - Running post-run listener: _resource_record_post_run 01:10:00 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 358453248; Read time: 20; Write time: 246052 01:10:00 INFO - TinderboxPrint: CPU usage
13.1% 01:10:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 01:10:00 INFO - TinderboxPrint: I/O write bytes / time
358,453,248 / 246,052 01:10:00 INFO - TinderboxPrint: CPU idle
8,316.6 (86.9%) 01:10:00 INFO - TinderboxPrint: CPU user
1,212.5 (12.7%) 01:10:00 INFO - TinderboxPrint: Swap in / out
0 / 0 01:10:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 69779456; Read time: 0; Write time: 39908 01:10:00 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 287907840; Read time: 0; Write time: 206076 01:10:00 INFO - Running post-run listener: _upload_blobber_files 01:10:00 INFO - Blob upload gear active. 01:10:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:10:00 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 01:10:00 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'] 01:10:00 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 01:10:01 INFO - (blobuploader) - INFO - Open directory for files ... 01:10:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:10:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:10:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:10:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:10:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:10:02 INFO - (blobuploader) - INFO - Done attempting. 01:10:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:10:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:10:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:10:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:10:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:10:06 INFO - (blobuploader) - INFO - Done attempting. 01:10:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:10:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:10:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:10:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:10:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:10:06 INFO - (blobuploader) - INFO - Done attempting. 01:10:06 INFO - (blobuploader) - INFO - Iteration through files over. 01:10:06 INFO - Return code: 0 01:10:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:10:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:10:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb35e4a604c1b87ec42ca6954151da82dd6c4bb797fb9090faf37a6da584f877ac51838ea4d61ee6151a40b9cb28786cf0e4ab507bf4ceed5d916dc8aa99ddc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2142d6aa1c54dab9842a57476d279c1fc494f1e498ad4089ce00e7f3a4de9bd80dbaa10237edeb6c60d2cc06cbc0f1fd045dd744366ff1593fd05553a590900", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cce1900b2103f99cc8497c960cd98105201f5a36d9a777a930d1679a18ef683f756df45af556dbd31a51f7c18813df7c6d56a56552f0c68961544ffdd07ca84e"} 01:10:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:10:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:10:06 INFO - Contents: 01:10:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb35e4a604c1b87ec42ca6954151da82dd6c4bb797fb9090faf37a6da584f877ac51838ea4d61ee6151a40b9cb28786cf0e4ab507bf4ceed5d916dc8aa99ddc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2142d6aa1c54dab9842a57476d279c1fc494f1e498ad4089ce00e7f3a4de9bd80dbaa10237edeb6c60d2cc06cbc0f1fd045dd744366ff1593fd05553a590900", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cce1900b2103f99cc8497c960cd98105201f5a36d9a777a930d1679a18ef683f756df45af556dbd31a51f7c18813df7c6d56a56552f0c68961544ffdd07ca84e"} 01:10:06 INFO - Running post-run listener: copy_logs_to_upload_dir 01:10:06 INFO - Copying logs to upload dir... 01:10:06 INFO - mkdir: /builds/slave/test/build/upload/logs 01:10:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.503785 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-29 01:10:06.745786) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 01:10:06.750624) ========= 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=6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439 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/eb35e4a604c1b87ec42ca6954151da82dd6c4bb797fb9090faf37a6da584f877ac51838ea4d61ee6151a40b9cb28786cf0e4ab507bf4ceed5d916dc8aa99ddc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2142d6aa1c54dab9842a57476d279c1fc494f1e498ad4089ce00e7f3a4de9bd80dbaa10237edeb6c60d2cc06cbc0f1fd045dd744366ff1593fd05553a590900", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cce1900b2103f99cc8497c960cd98105201f5a36d9a777a930d1679a18ef683f756df45af556dbd31a51f7c18813df7c6d56a56552f0c68961544ffdd07ca84e"} build_url:https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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/eb35e4a604c1b87ec42ca6954151da82dd6c4bb797fb9090faf37a6da584f877ac51838ea4d61ee6151a40b9cb28786cf0e4ab507bf4ceed5d916dc8aa99ddc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2142d6aa1c54dab9842a57476d279c1fc494f1e498ad4089ce00e7f3a4de9bd80dbaa10237edeb6c60d2cc06cbc0f1fd045dd744366ff1593fd05553a590900", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cce1900b2103f99cc8497c960cd98105201f5a36d9a777a930d1679a18ef683f756df45af556dbd31a51f7c18813df7c6d56a56552f0c68961544ffdd07ca84e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 01:10:06.778432) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 01:10:06.778741) ========= 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=6dbc10da6d83fee962c624be000001a8-1467186552.599165-617070439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 01:10:06.858027) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 01:10:06.861375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 01:10:06.861661) ========= ========= Total master_lag: 0.27 =========