builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1467143653.44 results: success (0) buildid: 20160628113822 builduid: 2a860460dfac4910bd597f7937487a03 revision: 5b3be977f2a28eaeed03b68c87bd1e7fa898ed25 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:13.436330) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:13.437009) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:13.437374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:13.475125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:13.475459) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 12:54:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.8M=0s 2016-06-28 12:54:14 (38.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122591 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:13.622799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:13.623158) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017163 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:13.676759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:13.680167) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5b3be977f2a28eaeed03b68c87bd1e7fa898ed25 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 5b3be977f2a28eaeed03b68c87bd1e7fa898ed25 --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=6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 12:54:14,420 truncating revision to first 12 chars 2016-06-28 12:54:14,420 Setting DEBUG logging. 2016-06-28 12:54:14,420 attempt 1/10 2016-06-28 12:54:14,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5b3be977f2a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 12:54:14,725 unpacking tar archive at: autoland-5b3be977f2a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663226 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:14.370967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:14.374345) ========= script_repo_revision: 5b3be977f2a28eaeed03b68c87bd1e7fa898ed25 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:14.374789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:14.375136) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:14.388173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-28 12:54:14.388481) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:54:15 INFO - MultiFileLogger online at 20160628 12:54:15 in /builds/slave/test 12:54:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 12:54:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:15 INFO - {'append_to_log': False, 12:54:15 INFO - 'base_work_dir': '/builds/slave/test', 12:54:15 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:54:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:15 INFO - 'branch': 'Autoland-Non-PGO', 12:54:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:15 INFO - 'config_files': ('talos/linux_config.py',), 12:54:15 INFO - 'default_actions': ('clobber', 12:54:15 INFO - 'read-buildbot-config', 12:54:15 INFO - 'download-and-extract', 12:54:15 INFO - 'populate-webroot', 12:54:15 INFO - 'create-virtualenv', 12:54:15 INFO - 'install', 12:54:15 INFO - 'run-tests'), 12:54:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:15 INFO - 'download_minidump_stackwalk': True, 12:54:15 INFO - 'download_symbols': 'ondemand', 12:54:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:15 INFO - 'installer_path': 'installer.exe', 12:54:15 INFO - 'log_level': 'info', 12:54:15 INFO - 'log_name': 'talos', 12:54:15 INFO - 'log_to_console': True, 12:54:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:54:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:54:15 INFO - 'opt_config_files': (), 12:54:15 INFO - 'pip_index': False, 12:54:15 INFO - 'sps_profile': False, 12:54:15 INFO - 'sps_profile_interval': 0, 12:54:15 INFO - 'suite': 'dromaeojs', 12:54:15 INFO - 'system_bits': '32', 12:54:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:15 INFO - 'title': 'talos-linux64-ix-023', 12:54:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:15 INFO - 'use_talos_json': True, 12:54:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:15 INFO - 'work_dir': 'build'} 12:54:15 INFO - ##### 12:54:15 INFO - ##### Running clobber step. 12:54:15 INFO - ##### 12:54:15 INFO - Running pre-action listener: _resource_record_pre_action 12:54:15 INFO - Running main action method: clobber 12:54:15 INFO - rmtree: /builds/slave/test/build 12:54:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:15 INFO - Running post-action listener: _resource_record_post_action 12:54:15 INFO - ##### 12:54:15 INFO - ##### Finished clobber step (success) 12:54:15 INFO - ##### 12:54:15 INFO - ##### 12:54:15 INFO - ##### Running read-buildbot-config step. 12:54:15 INFO - ##### 12:54:15 INFO - Running pre-action listener: _resource_record_pre_action 12:54:15 INFO - Running main action method: read_buildbot_config 12:54:15 INFO - Using buildbot properties: 12:54:15 INFO - { 12:54:15 INFO - "project": "", 12:54:15 INFO - "product": "firefox", 12:54:15 INFO - "script_repo_revision": "production", 12:54:15 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:54:15 INFO - "repository": "", 12:54:15 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 12:54:15 INFO - "buildid": "20160628113822", 12:54:15 INFO - "pgo_build": "False", 12:54:15 INFO - "basedir": "/builds/slave/test", 12:54:15 INFO - "buildnumber": 8, 12:54:15 INFO - "slavename": "talos-linux64-ix-023", 12:54:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:54:15 INFO - "platform": "ubuntu64_hw", 12:54:15 INFO - "scheduler": "tests-autoland-linux64-talos", 12:54:15 INFO - "branch": "autoland", 12:54:15 INFO - "repo_path": "integration/autoland", 12:54:15 INFO - "revision": "5b3be977f2a28eaeed03b68c87bd1e7fa898ed25", 12:54:15 INFO - "stage_platform": "linux64", 12:54:15 INFO - "builduid": "2a860460dfac4910bd597f7937487a03", 12:54:15 INFO - "slavebuilddir": "test" 12:54:15 INFO - } 12:54:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:54:15 INFO - Running post-action listener: _resource_record_post_action 12:54:15 INFO - ##### 12:54:15 INFO - ##### Finished read-buildbot-config step (success) 12:54:15 INFO - ##### 12:54:15 INFO - ##### 12:54:15 INFO - ##### Running download-and-extract step. 12:54:15 INFO - ##### 12:54:15 INFO - Running pre-action listener: _resource_record_pre_action 12:54:15 INFO - Running main action method: download_and_extract 12:54:15 INFO - mkdir: /builds/slave/test/build/tests 12:54: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')]} 12:54:15 INFO - https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:54:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:54:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:54:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/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 12:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/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 12:54:19 INFO - Downloaded 1361 bytes. 12:54:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:54:19 INFO - Using the following test package requirements: 12:54:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:54:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:54:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:19 INFO - u'jsshell-linux-x86_64.zip'], 12:54:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:54:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:54:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:54:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:54:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:54:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:54: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')]} 12:54:19 INFO - https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:54:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:54:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:54:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/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 12:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/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 12:54:23 INFO - Downloaded 22700063 bytes. 12:54:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:54:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:54:24 INFO - Return code: 0 12:54:24 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 12:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:24 INFO - https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/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 12:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/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 12:54:36 INFO - Downloaded 22700063 bytes. 12:54:36 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'] 12:54:36 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 12:54:37 INFO - Return code: 0 12:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:37 INFO - https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:54:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:54:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:54:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/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 12:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/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 12:54:38 INFO - Downloaded 14405245 bytes. 12:54:38 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'] 12:54:38 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 12:54:38 INFO - Return code: 0 12:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:38 INFO - https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/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 12:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzrzLgMjS72vFAtZTBu8rA/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 12:54:44 INFO - Downloaded 56438805 bytes. 12:54:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:54:44 INFO - mkdir: /builds/slave/test/properties 12:54:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:44 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:44 INFO - Contents: 12:54:44 INFO - build_url:https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:54:45 INFO - Running post-action listener: _resource_record_post_action 12:54:45 INFO - Running post-action listener: set_extra_try_arguments 12:54:45 INFO - ##### 12:54:45 INFO - ##### Finished download-and-extract step (success) 12:54:45 INFO - ##### 12:54:45 INFO - ##### 12:54:45 INFO - ##### Running populate-webroot step. 12:54:45 INFO - ##### 12:54:45 INFO - Running pre-action listener: _resource_record_pre_action 12:54:45 INFO - Running main action method: populate_webroot 12:54:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:45 INFO - '--tppagecycles', 12:54:45 INFO - '7'], 12:54:45 INFO - 'tests': ['tsvgm']}}, 12:54:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:45 INFO - 'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:45 INFO - 'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['damp', 'tps']}, 12:54:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:45 INFO - 'tests': ['damp', 'tps']}, 12:54:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['dromaeo_dom']}, 12:54:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['basic_compositor_video']}, 12:54:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:54:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['a11yr', 12:54:45 INFO - 'ts_paint', 12:54:45 INFO - 'tpaint', 12:54:45 INFO - 'sessionrestore', 12:54:45 INFO - 'sessionrestore_no_auto_restore', 12:54:45 INFO - 'tabpaint']}, 12:54:45 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:45 INFO - 'ts_paint', 12:54:45 INFO - 'tpaint', 12:54:45 INFO - 'sessionrestore', 12:54:45 INFO - 'sessionrestore_no_auto_restore', 12:54:45 INFO - 'tabpaint']}, 12:54:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:45 INFO - 'ts_paint', 12:54:45 INFO - 'tpaint', 12:54:45 INFO - 'sessionrestore', 12:54:45 INFO - 'sessionrestore_no_auto_restore', 12:54:45 INFO - 'tabpaint']}, 12:54:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:45 INFO - 'ts_paint', 12:54:45 INFO - 'tpaint', 12:54:45 INFO - 'sessionrestore', 12:54:45 INFO - 'sessionrestore_no_auto_restore', 12:54:45 INFO - 'tabpaint']}, 12:54:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['a11yr', 12:54:45 INFO - 'ts_paint', 12:54:45 INFO - 'tpaint', 12:54:45 INFO - 'sessionrestore', 12:54:45 INFO - 'sessionrestore_no_auto_restore', 12:54:45 INFO - 'tabpaint']}, 12:54:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['a11yr', 12:54:45 INFO - 'ts_paint', 12:54:45 INFO - 'tpaint', 12:54:45 INFO - 'sessionrestore', 12:54:45 INFO - 'sessionrestore_no_auto_restore', 12:54:45 INFO - 'tabpaint']}, 12:54:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['tsvgx', 12:54:45 INFO - 'tsvgr_opacity', 12:54:45 INFO - 'tart', 12:54:45 INFO - 'tscrollx', 12:54:45 INFO - 'cart']}, 12:54:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:45 INFO - 'tsvgr_opacity', 12:54:45 INFO - 'tart', 12:54:45 INFO - 'tscrollx', 12:54:45 INFO - 'cart']}, 12:54:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:45 INFO - 'talos_options': ['--disable-e10s'], 12:54:45 INFO - 'tests': ['tp5o']}, 12:54:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:45 INFO - 'tests': ['tp5o']}, 12:54:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:45 INFO - 'talos_options': ['--disable-e10s', 12:54:45 INFO - '--xperf_path', 12:54:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:45 INFO - 'tests': ['tp5n']}, 12:54:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:45 INFO - 'talos_options': ['--xperf_path', 12:54:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:45 INFO - 'tests': ['tp5n']}}, 12:54:45 INFO - 'talos.zip': {'path': '', 12:54:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:45 INFO - Running post-action listener: _resource_record_post_action 12:54:45 INFO - ##### 12:54:45 INFO - ##### Finished populate-webroot step (success) 12:54:45 INFO - ##### 12:54:45 INFO - ##### 12:54:45 INFO - ##### Running create-virtualenv step. 12:54:45 INFO - ##### 12:54:45 INFO - Running pre-action listener: _resource_record_pre_action 12:54:45 INFO - Running main action method: create_virtualenv 12:54:45 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:45 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 12:54:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:45 INFO - Using real prefix '/usr' 12:54:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:46 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:47 INFO - Installing pip.................done. 12:54:47 INFO - Return code: 0 12:54:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:47 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 0x1f29030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e83b0>, '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 0x21e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', '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 12:54:47 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 12:54:47 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 12:54:47 INFO - Using env: {'DISPLAY': ':0', 12:54:47 INFO - 'HOME': '/home/cltbld', 12:54:47 INFO - 'LANG': 'en_US.UTF-8', 12:54:47 INFO - 'LANGUAGE': 'en_US:en', 12:54:47 INFO - 'LOGNAME': 'cltbld', 12:54:47 INFO - 'MAIL': '/var/mail/cltbld', 12:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:47 INFO - 'MOZ_NO_REMOTE': '1', 12:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:47 INFO - 'NO_EM_RESTART': '1', 12:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:47 INFO - 'PWD': '/builds/slave/test', 12:54:47 INFO - 'SHELL': '/bin/bash', 12:54:47 INFO - 'SHLVL': '1', 12:54:47 INFO - 'TERM': 'linux', 12:54:47 INFO - 'TMOUT': '86400', 12:54:47 INFO - 'USER': 'cltbld', 12:54:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', 12:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:47 INFO - '_': '/tools/buildbot/bin/python'} 12:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:48 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 12:54:48 INFO - Cleaning up... 12:54:48 INFO - Return code: 0 12:54:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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', '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 0x1f29030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e83b0>, '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 0x21e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', '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 12:54: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:54: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 psutil>=3.1.1 12:54:48 INFO - Using env: {'DISPLAY': ':0', 12:54:48 INFO - 'HOME': '/home/cltbld', 12:54:48 INFO - 'LANG': 'en_US.UTF-8', 12:54:48 INFO - 'LANGUAGE': 'en_US:en', 12:54:48 INFO - 'LOGNAME': 'cltbld', 12:54:48 INFO - 'MAIL': '/var/mail/cltbld', 12:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:48 INFO - 'MOZ_NO_REMOTE': '1', 12:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:48 INFO - 'NO_EM_RESTART': '1', 12:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:48 INFO - 'PWD': '/builds/slave/test', 12:54:48 INFO - 'SHELL': '/bin/bash', 12:54:48 INFO - 'SHLVL': '1', 12:54:48 INFO - 'TERM': 'linux', 12:54:48 INFO - 'TMOUT': '86400', 12:54:48 INFO - 'USER': 'cltbld', 12:54:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', 12:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:48 INFO - '_': '/tools/buildbot/bin/python'} 12:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:48 INFO - Downloading/unpacking psutil>=3.1.1 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:50 INFO - Installing collected packages: psutil 12:54:50 INFO - Running setup.py install for psutil 12:54:50 INFO - building 'psutil._psutil_linux' extension 12:54:50 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 12:54:50 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 12:54:50 INFO - building 'psutil._psutil_posix' extension 12:54:50 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 12:54:50 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 12:54:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:50 INFO - Successfully installed psutil 12:54:50 INFO - Cleaning up... 12:54:50 INFO - Return code: 0 12:54:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e83b0>, '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 0x21e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', '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 12:54:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:54:51 INFO - Using env: {'DISPLAY': ':0', 12:54:51 INFO - 'HOME': '/home/cltbld', 12:54:51 INFO - 'LANG': 'en_US.UTF-8', 12:54:51 INFO - 'LANGUAGE': 'en_US:en', 12:54:51 INFO - 'LOGNAME': 'cltbld', 12:54:51 INFO - 'MAIL': '/var/mail/cltbld', 12:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:51 INFO - 'MOZ_NO_REMOTE': '1', 12:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:51 INFO - 'NO_EM_RESTART': '1', 12:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:51 INFO - 'PWD': '/builds/slave/test', 12:54:51 INFO - 'SHELL': '/bin/bash', 12:54:51 INFO - 'SHLVL': '1', 12:54:51 INFO - 'TERM': 'linux', 12:54:51 INFO - 'TMOUT': '86400', 12:54:51 INFO - 'USER': 'cltbld', 12:54:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', 12:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:51 INFO - '_': '/tools/buildbot/bin/python'} 12:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:53 INFO - Installing collected packages: mozsystemmonitor 12:54:53 INFO - Running setup.py install for mozsystemmonitor 12:54:53 INFO - Successfully installed mozsystemmonitor 12:54:53 INFO - Cleaning up... 12:54:53 INFO - Return code: 0 12:54:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f29030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e83b0>, '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 0x21e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', '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 12:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:54:53 INFO - Using env: {'DISPLAY': ':0', 12:54:53 INFO - 'HOME': '/home/cltbld', 12:54:53 INFO - 'LANG': 'en_US.UTF-8', 12:54:53 INFO - 'LANGUAGE': 'en_US:en', 12:54:53 INFO - 'LOGNAME': 'cltbld', 12:54:53 INFO - 'MAIL': '/var/mail/cltbld', 12:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:53 INFO - 'MOZ_NO_REMOTE': '1', 12:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:53 INFO - 'NO_EM_RESTART': '1', 12:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:53 INFO - 'PWD': '/builds/slave/test', 12:54:53 INFO - 'SHELL': '/bin/bash', 12:54:53 INFO - 'SHLVL': '1', 12:54:53 INFO - 'TERM': 'linux', 12:54:53 INFO - 'TMOUT': '86400', 12:54:53 INFO - 'USER': 'cltbld', 12:54:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', 12:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:53 INFO - '_': '/tools/buildbot/bin/python'} 12:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:53 INFO - Downloading/unpacking jsonschema==2.5.1 12:54:53 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 12:54:53 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 12:54:53 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 12:54:53 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 12:54:53 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 12:54:53 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 12:54:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:55 INFO - warning: no files found matching '*.txt' 12:54:55 INFO - no previously-included directories found matching 'build' 12:54:55 INFO - no previously-included directories found matching 'dist' 12:54:55 INFO - no previously-included directories found matching '.git*' 12:54:55 INFO - Installing collected packages: jsonschema, functools32 12:54:55 INFO - Running setup.py install for functools32 12:54:55 INFO - warning: no files found matching '*.txt' 12:54:55 INFO - no previously-included directories found matching 'build' 12:54:55 INFO - no previously-included directories found matching 'dist' 12:54:55 INFO - no previously-included directories found matching '.git*' 12:54:55 INFO - Successfully installed jsonschema functools32 12:54:55 INFO - Cleaning up... 12:54:55 INFO - Return code: 0 12:54:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:55 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 0x1f29030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e83b0>, '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 0x21e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', '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 12:54:55 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 12:54:55 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 12:54:55 INFO - Using env: {'DISPLAY': ':0', 12:54:55 INFO - 'HOME': '/home/cltbld', 12:54:55 INFO - 'LANG': 'en_US.UTF-8', 12:54:55 INFO - 'LANGUAGE': 'en_US:en', 12:54:55 INFO - 'LOGNAME': 'cltbld', 12:54:55 INFO - 'MAIL': '/var/mail/cltbld', 12:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:55 INFO - 'MOZ_NO_REMOTE': '1', 12:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:55 INFO - 'NO_EM_RESTART': '1', 12:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:55 INFO - 'PWD': '/builds/slave/test', 12:54:55 INFO - 'SHELL': '/bin/bash', 12:54:55 INFO - 'SHLVL': '1', 12:54:55 INFO - 'TERM': 'linux', 12:54:55 INFO - 'TMOUT': '86400', 12:54:55 INFO - 'USER': 'cltbld', 12:54:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', 12:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:55 INFO - '_': '/tools/buildbot/bin/python'} 12:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:58 INFO - Downloading docopt-0.6.1.tar.gz 12:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:58 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:58 INFO - Running setup.py install for blobuploader 12:54:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:58 INFO - Running setup.py install for requests 12:54:59 INFO - Running setup.py install for docopt 12:54:59 INFO - Successfully installed blobuploader requests docopt 12:54:59 INFO - Cleaning up... 12:54:59 INFO - Return code: 0 12:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:59 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 0x1f29030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e83b0>, '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 0x21e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', '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 12:54:59 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 12:54:59 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 12:54:59 INFO - Using env: {'DISPLAY': ':0', 12:54:59 INFO - 'HOME': '/home/cltbld', 12:54:59 INFO - 'LANG': 'en_US.UTF-8', 12:54:59 INFO - 'LANGUAGE': 'en_US:en', 12:54:59 INFO - 'LOGNAME': 'cltbld', 12:54:59 INFO - 'MAIL': '/var/mail/cltbld', 12:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:59 INFO - 'MOZ_NO_REMOTE': '1', 12:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:59 INFO - 'NO_EM_RESTART': '1', 12:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:59 INFO - 'PWD': '/builds/slave/test', 12:54:59 INFO - 'SHELL': '/bin/bash', 12:54:59 INFO - 'SHLVL': '1', 12:54:59 INFO - 'TERM': 'linux', 12:54:59 INFO - 'TMOUT': '86400', 12:54:59 INFO - 'USER': 'cltbld', 12:54:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', 12:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:59 INFO - '_': '/tools/buildbot/bin/python'} 12:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:59 INFO - Running setup.py (path:/tmp/pip-fVbKOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:59 INFO - Running setup.py (path:/tmp/pip-6L0DvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:59 INFO - Running setup.py (path:/tmp/pip-a69jdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:59 INFO - Running setup.py (path:/tmp/pip-f3X356-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:59 INFO - Running setup.py (path:/tmp/pip-a02QUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:59 INFO - Running setup.py (path:/tmp/pip-zzJycz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:59 INFO - Running setup.py (path:/tmp/pip-D5UG8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:00 INFO - Running setup.py (path:/tmp/pip-_nUeZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:00 INFO - Running setup.py (path:/tmp/pip-zVfzls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:00 INFO - Running setup.py (path:/tmp/pip-wU5_WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:00 INFO - Running setup.py (path:/tmp/pip-EXqhAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:00 INFO - Running setup.py (path:/tmp/pip-R1YEPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:00 INFO - Running setup.py (path:/tmp/pip-SFXfr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:00 INFO - Running setup.py (path:/tmp/pip-k_C1fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:00 INFO - Running setup.py (path:/tmp/pip-Ks1nsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:00 INFO - Running setup.py (path:/tmp/pip-tcWf8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:00 INFO - Running setup.py (path:/tmp/pip-yomy2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:55:00 INFO - Running setup.py install for manifestparser 12:55:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:55:00 INFO - Running setup.py install for mozcrash 12:55:00 INFO - Running setup.py install for mozdebug 12:55:01 INFO - Running setup.py install for mozdevice 12:55:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:55:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:55:01 INFO - Running setup.py install for mozfile 12:55:01 INFO - Running setup.py install for mozhttpd 12:55:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:55:01 INFO - Running setup.py install for mozinfo 12:55:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:55:01 INFO - Running setup.py install for mozInstall 12:55:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:55:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:55:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:55:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:55:01 INFO - Running setup.py install for mozleak 12:55:01 INFO - Running setup.py install for mozlog 12:55:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:55:01 INFO - Running setup.py install for moznetwork 12:55:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:55:01 INFO - Running setup.py install for mozprocess 12:55:02 INFO - Running setup.py install for mozprofile 12:55:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:55:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:55:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:55:02 INFO - Running setup.py install for mozrunner 12:55:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:55:02 INFO - Running setup.py install for mozscreenshot 12:55:02 INFO - Running setup.py install for moztest 12:55:02 INFO - Running setup.py install for mozversion 12:55:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:55:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:55:02 INFO - Cleaning up... 12:55:02 INFO - Return code: 0 12:55:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:02 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 0x1f29030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e83b0>, '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 0x21e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', '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 12:55:02 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 12:55:02 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 12:55:02 INFO - Using env: {'DISPLAY': ':0', 12:55:02 INFO - 'HOME': '/home/cltbld', 12:55:02 INFO - 'LANG': 'en_US.UTF-8', 12:55:02 INFO - 'LANGUAGE': 'en_US:en', 12:55:02 INFO - 'LOGNAME': 'cltbld', 12:55:02 INFO - 'MAIL': '/var/mail/cltbld', 12:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:02 INFO - 'MOZ_NO_REMOTE': '1', 12:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:02 INFO - 'NO_EM_RESTART': '1', 12:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:02 INFO - 'PWD': '/builds/slave/test', 12:55:02 INFO - 'SHELL': '/bin/bash', 12:55:02 INFO - 'SHLVL': '1', 12:55:02 INFO - 'TERM': 'linux', 12:55:02 INFO - 'TMOUT': '86400', 12:55:02 INFO - 'USER': 'cltbld', 12:55:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', 12:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:02 INFO - '_': '/tools/buildbot/bin/python'} 12:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:55:02 INFO - Running setup.py (path:/tmp/pip-Pl7YS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:55:02 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)) 12:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:55:02 INFO - Running setup.py (path:/tmp/pip-q7ewZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:55:02 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)) 12:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:55:02 INFO - Running setup.py (path:/tmp/pip-hZFFjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:55:02 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)) 12:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:55:03 INFO - Running setup.py (path:/tmp/pip-5ii6uR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:55:03 INFO - Running setup.py (path:/tmp/pip-6k6ozy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:55:03 INFO - Running setup.py (path:/tmp/pip-4ZAhqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:55:03 INFO - Running setup.py (path:/tmp/pip-Tizlbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:03 INFO - Running setup.py (path:/tmp/pip-vCpjZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:03 INFO - Running setup.py (path:/tmp/pip-yIIhff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:03 INFO - Running setup.py (path:/tmp/pip-FazAx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:03 INFO - Running setup.py (path:/tmp/pip-9HAiGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:03 INFO - Running setup.py (path:/tmp/pip-7dxmU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:03 INFO - Running setup.py (path:/tmp/pip-7YXoVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:03 INFO - Running setup.py (path:/tmp/pip-kpO3rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:03 INFO - Running setup.py (path:/tmp/pip-FyyXy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:03 INFO - Running setup.py (path:/tmp/pip-EcBWH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:03 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)) 12:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:03 INFO - Running setup.py (path:/tmp/pip-avq5dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:04 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)) 12:55:04 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)) 12:55:04 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)) 12:55:04 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)) 12:55:04 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)) 12:55:04 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)) 12:55:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:55:04 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 12:55:04 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 12:55:04 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 12:55:04 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 12:55:04 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 12:55:04 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 12:55:06 INFO - Downloading blessings-1.6.tar.gz 12:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:55:06 INFO - Installing collected packages: blessings 12:55:06 INFO - Running setup.py install for blessings 12:55:06 INFO - Successfully installed blessings 12:55:06 INFO - Cleaning up... 12:55:06 INFO - Return code: 0 12:55:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:55:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:06 INFO - Reading from file tmpfile_stdout 12:55:06 INFO - Current package versions: 12:55:06 INFO - argparse == 1.2.1 12:55:06 INFO - blessings == 1.6 12:55:06 INFO - blobuploader == 1.2.4 12:55:06 INFO - docopt == 0.6.1 12:55:06 INFO - functools32 == 3.2.3-2 12:55:06 INFO - jsonschema == 2.5.1 12:55:06 INFO - manifestparser == 1.1 12:55:06 INFO - mozInstall == 1.12 12:55:06 INFO - mozcrash == 0.17 12:55:06 INFO - mozdebug == 0.1 12:55:06 INFO - mozdevice == 0.48 12:55:06 INFO - mozfile == 1.2 12:55:06 INFO - mozhttpd == 0.7 12:55:06 INFO - mozinfo == 0.9 12:55:06 INFO - mozleak == 0.1 12:55:06 INFO - mozlog == 3.2 12:55:06 INFO - moznetwork == 0.27 12:55:06 INFO - mozprocess == 0.22 12:55:06 INFO - mozprofile == 0.28 12:55:06 INFO - mozrunner == 6.11 12:55:06 INFO - mozscreenshot == 0.1 12:55:06 INFO - mozsystemmonitor == 0.3 12:55:06 INFO - moztest == 0.7 12:55:06 INFO - mozversion == 1.4 12:55:06 INFO - psutil == 3.1.1 12:55:06 INFO - requests == 1.2.3 12:55:06 INFO - wsgiref == 0.1.2 12:55:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:06 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 0x1f29030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e83b0>, '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 0x21e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', '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 12:55:06 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 12:55:06 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 12:55:06 INFO - Using env: {'DISPLAY': ':0', 12:55:06 INFO - 'HOME': '/home/cltbld', 12:55:06 INFO - 'LANG': 'en_US.UTF-8', 12:55:06 INFO - 'LANGUAGE': 'en_US:en', 12:55:06 INFO - 'LOGNAME': 'cltbld', 12:55:06 INFO - 'MAIL': '/var/mail/cltbld', 12:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:06 INFO - 'MOZ_NO_REMOTE': '1', 12:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:06 INFO - 'NO_EM_RESTART': '1', 12:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:06 INFO - 'PWD': '/builds/slave/test', 12:55:06 INFO - 'SHELL': '/bin/bash', 12:55:06 INFO - 'SHLVL': '1', 12:55:06 INFO - 'TERM': 'linux', 12:55:06 INFO - 'TMOUT': '86400', 12:55:06 INFO - 'USER': 'cltbld', 12:55:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', 12:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:06 INFO - '_': '/tools/buildbot/bin/python'} 12:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:07 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)) 12:55:07 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)) 12:55:07 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)) 12:55:07 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)) 12:55:07 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)) 12:55:07 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)) 12:55:07 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)) 12:55:07 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)) 12:55:07 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)) 12:55:07 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)) 12:55:07 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)) 12:55:07 INFO - Cleaning up... 12:55:07 INFO - Return code: 0 12:55:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:55:07 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')]} 12:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:07 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')]} 12:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:07 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 0x1f29030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e83b0>, '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 0x21e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', '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 12:55:07 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 12:55:07 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 12:55:07 INFO - Using env: {'DISPLAY': ':0', 12:55:07 INFO - 'HOME': '/home/cltbld', 12:55:07 INFO - 'LANG': 'en_US.UTF-8', 12:55:07 INFO - 'LANGUAGE': 'en_US:en', 12:55:07 INFO - 'LOGNAME': 'cltbld', 12:55:07 INFO - 'MAIL': '/var/mail/cltbld', 12:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:07 INFO - 'MOZ_NO_REMOTE': '1', 12:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:07 INFO - 'NO_EM_RESTART': '1', 12:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:07 INFO - 'PWD': '/builds/slave/test', 12:55:07 INFO - 'SHELL': '/bin/bash', 12:55:07 INFO - 'SHLVL': '1', 12:55:07 INFO - 'TERM': 'linux', 12:55:07 INFO - 'TMOUT': '86400', 12:55:07 INFO - 'USER': 'cltbld', 12:55:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', 12:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:07 INFO - '_': '/tools/buildbot/bin/python'} 12:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:55:07 INFO - Cleaning up... 12:55:07 INFO - Return code: 0 12:55:07 INFO - Running post-action listener: _resource_record_post_action 12:55:07 INFO - Running post-action listener: _start_resource_monitoring 12:55:07 INFO - Starting resource monitoring. 12:55:07 INFO - ##### 12:55:07 INFO - ##### Finished create-virtualenv step (success) 12:55:07 INFO - ##### 12:55:07 INFO - ##### 12:55:07 INFO - ##### Running install step. 12:55:07 INFO - ##### 12:55:07 INFO - Running pre-action listener: _resource_record_pre_action 12:55:07 INFO - Running main action method: install 12:55:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:07 INFO - Reading from file tmpfile_stdout 12:55:07 INFO - Detecting whether we're running mozinstall >=1.0... 12:55:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:55:07 INFO - Reading from file tmpfile_stdout 12:55:07 INFO - Output received: 12:55:07 INFO - Usage: mozinstall [options] installer 12:55:07 INFO - Options: 12:55:07 INFO - -h, --help show this help message and exit 12:55:07 INFO - -d DEST, --destination=DEST 12:55:07 INFO - Directory to install application into. [default: 12:55:07 INFO - "/builds/slave/test"] 12:55:07 INFO - --app=APP Application being installed. [default: firefox] 12:55:07 INFO - mkdir: /builds/slave/test/build/application 12:55:07 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'] 12:55:07 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 12:55:23 INFO - Reading from file tmpfile_stdout 12:55:23 INFO - Output received: 12:55:23 INFO - /builds/slave/test/build/application/firefox/firefox 12:55:23 INFO - Running post-action listener: _resource_record_post_action 12:55:23 INFO - ##### 12:55:23 INFO - ##### Finished install step (success) 12:55:23 INFO - ##### 12:55:23 INFO - ##### 12:55:23 INFO - ##### Running run-tests step. 12:55:23 INFO - ##### 12:55:23 INFO - Running pre-action listener: _resource_record_pre_action 12:55:23 INFO - Running main action method: run_tests 12:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:55:23 INFO - Python 2.7.3 12:55:23 INFO - Return code: 0 12:55:23 INFO - grabbing minidump binary from tooltool 12:55:23 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')]} 12:55:23 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 0x21e83b0>, '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 0x21e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:55:23 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 12:55:23 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 12:55:23 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 12:55:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:55:24 INFO - Return code: 0 12:55:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:55:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:55:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:55:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:55:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 12:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 12:55:24 INFO - Using env: {'DISPLAY': ':0', 12:55:24 INFO - 'HOME': '/home/cltbld', 12:55:24 INFO - 'LANG': 'en_US.UTF-8', 12:55:24 INFO - 'LANGUAGE': 'en_US:en', 12:55:24 INFO - 'LOGNAME': 'cltbld', 12:55:24 INFO - 'MAIL': '/var/mail/cltbld', 12:55:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:55:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:24 INFO - 'MOZ_NO_REMOTE': '1', 12:55:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:24 INFO - 'NO_EM_RESTART': '1', 12:55:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:24 INFO - 'PWD': '/builds/slave/test', 12:55:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:55:24 INFO - 'SHELL': '/bin/bash', 12:55:24 INFO - 'SHLVL': '1', 12:55:24 INFO - 'TERM': 'linux', 12:55:24 INFO - 'TMOUT': '86400', 12:55:24 INFO - 'USER': 'cltbld', 12:55:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339', 12:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:24 INFO - '_': '/tools/buildbot/bin/python'} 12:55:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 12:55:24 INFO - mozversion application_buildid: 20160628113822 12:55:24 INFO - mozversion application_changeset: 5b3be977f2a28eaeed03b68c87bd1e7fa898ed25 12:55:24 INFO - mozversion application_display_name: Nightly 12:55:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:55:24 INFO - mozversion application_name: Firefox 12:55:24 INFO - mozversion application_remotingname: firefox 12:55:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:55:24 INFO - mozversion application_vendor: Mozilla 12:55:24 INFO - mozversion application_version: 50.0a1 12:55:24 INFO - mozversion platform_buildid: 20160628113822 12:55:24 INFO - mozversion platform_changeset: 5b3be977f2a28eaeed03b68c87bd1e7fa898ed25 12:55:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:55:24 INFO - mozversion platform_version: 50.0a1 12:55:24 INFO - using testdate: 1467143724 12:55:24 INFO - actual date: 1467143724 12:55:24 INFO - starting webserver on 'localhost:48065' 12:55:24 INFO - SUITE-START | Running 2 tests 12:55:24 INFO - TEST-START | dromaeo_css 12:55:24 INFO - operating with platform_type : linux_ 12:55:24 INFO - Initialising browser for dromaeo_css test... 12:55:24 INFO - TEST-INFO | started process 2716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwGb9sC/profile http://localhost:48065/getInfo.html) 12:55:28 INFO - PROCESS | 2716 | __metrics Screen width/height:1600/1200 12:55:28 INFO - PROCESS | 2716 | colorDepth:24 12:55:28 INFO - PROCESS | 2716 | Browser inner width/height: 1024/697 12:55:28 INFO - PROCESS | 2716 | __metrics 12:55:29 INFO - PROCESS | 2716 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:55:30 INFO - TEST-INFO | 2716: exit 0 12:55:30 INFO - Browser initialized. 12:55:30 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:30 INFO - TEST-INFO | started process 2872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwGb9sC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:42 INFO - PROCESS | 2872 | RSS: Main: 158433280 12:55:42 INFO - PROCESS | 2872 | 12:56:33 INFO - PROCESS | 2872 | 1467143793729 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] 12:58:46 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:48065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48065/tests/dromaeo/cssquery-ext.html) 12:58:47 INFO - PROCESS | 2872 | RSS: Main: 233488384 12:58:47 INFO - PROCESS | 2872 | 13:01:50 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:48065/tests/dromaeo/cssquery-ext.html (next: http://localhost:48065/tests/dromaeo/cssquery-jquery.html) 13:01:50 INFO - PROCESS | 2872 | RSS: Main: 243093504 13:01:50 INFO - PROCESS | 2872 | 13:04:53 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:48065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48065/tests/dromaeo/cssquery-mootools.html) 13:04:53 INFO - PROCESS | 2872 | RSS: Main: 237539328 13:04:53 INFO - PROCESS | 2872 | 13:07:56 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:48065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48065/tests/dromaeo/cssquery-prototype.html) 13:07:56 INFO - PROCESS | 2872 | RSS: Main: 240054272 13:07:56 INFO - PROCESS | 2872 | 13:10:59 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:48065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48065/tests/dromaeo/cssquery-yui.html) 13:11:00 INFO - PROCESS | 2872 | RSS: Main: 228044800 13:11:00 INFO - PROCESS | 2872 | 13:14:03 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:48065/tests/dromaeo/cssquery-yui.html (next: http://localhost:48065/tests/dromaeo/cssquery-dojo.html) 13:14:03 INFO - PROCESS | 2872 | RSS: Main: 275955712 13:14:03 INFO - PROCESS | 2872 | 13:14:03 INFO - PROCESS | 2872 | __start_tp_report 13:14:03 INFO - PROCESS | 2872 | _x_x_mozilla_page_load 13:14:03 INFO - PROCESS | 2872 | _x_x_mozilla_page_load_details 13:14:03 INFO - PROCESS | 2872 | |i|pagename|runs| 13:14:03 INFO - PROCESS | 2872 | |0;dojo.html;2593.157223902232;2625.5405304071783;2633.8024648151386;2644.7355264473554;2648.536506111431;4626.190416677085;4695.624350051996;4730.4559975602815;4748.050389922017;4826.0830442216;4747.430308363001;4752.691075080117;4767.284907263904;4808.975955120228;4809.687370320927;4340.240457919867;4352.455943007124;4419.027813880957;4450.755208463534;4585.79363928624;4461.754603496806;4504.459464864204;4510.684252102355;4514.864554063367;4549.476810166823;4332.458442694648;4391.429114215131;4394.055278115221;4421.137878113769;4452.554744525554;4354.673399495051;4355.041890784022;4355.303151495746;4465.307877279027;4491.483479399878;4370.8907277318;4388.626966707834;4389.582989615981;4394.123998296242;4436.245838207513;4691.437027556681;4769.3799806025345;4805.063012712522;4841.370621819176;4849.854504364875;5234.319538460014;5235.633505654568;5258.6318957672975;5260.500252476008;5262.0791361511965;5273.499017593323;5284.550813180885;5303.867403314909;5306.3632364116165;5307.495787900143;4705.388299521041;4779.904401911942;4824.6863953842885;4829.420469543607;4874.853754387339;5273.499017593323;5279.524842764093;5334.146536554133;5348.171033489815;5364.061289274361;5110.437851836295;5114.3095682083185;5124.666896651705;5124.897502049938;5129.051125541787;5006.624503162205;5081.8475445736685;5117.385913690381;5119.10415677255;5142.460041695643;5055.848324550269;5083.974580127076;5093.541581257705;5093.8726531837;5141.434442211354;4917.409910810654;5090.872728181825;5107.412647545506;5112.667676601009;5114.105031619451;4395.714278571946;4425.623821975104;4438.955610443919;4439.089986552749;4495.483019452805;3848.499695039627;3850.1914597934747;3855.691544676419;3899.707521935866;3904;4267.317229243306;4500.234960056799;4502.986827963682;4510.684252102387;4556.430446194226;4921.581665558396;4937.481564435682;5152.587792976553;5162.9741851291255;5221.686698798084;4449.466064072332;4476.597106260452;4479.955200447954;4483.596476317147;4521.954780452219;4529;4671.416072990876;4672.57946784791;4675.275332323496;4723.716577005322;4788.1381351356395;4815.831445899376;4822.252550854623;4837.3227748116;4849.709017458964;5143.2285157225215;5145.048166089286;5148.845534633967;5176.327077479904;5201.661891977009;4656.697314674535;4785.712857228577;4789.760511974457;4819.397575303087;4884.731339776346;5091.694498330112;5116.411612664591;5140.3831540215415;5146.819861304836;5191.32512773337;5196.116660167705;5223.791048358175;5226.843194704165;5233.659812112201;5283.075461794094;4916.188828843344;5005.249212618136;5010.123228435083;5068.2904393384215;5076.898462030813;5049.2930989660745;5079.263506791421;5081.466446023114;5088.643794934319;5122.385313762373;5015.122353588181;5015.247712843103;5019.67372120811;5038.319826823332;5060.139776237975;4909.533594308535;5002.849914502571;5056.266841308064;5057.46896575869;5151;4953.380827396575;4966.602671786321;4969.35398398206;4980.27785971025;5027.195648696191 13:14:03 INFO - PROCESS | 2872 | |1;ext.html;534.6921410891088;586.1530089021364;587.333376617539;595.8838026584813;604.921360223171;27019.729802701968;40315.798421007894;41500.37749433761;41522.37716434256;41634.58365416352;39695.60304396955;40010.399844002364;40021.39967900484;40076.39885401714;40181.59818401815;7647.235276472336;7805.6487458064385;7907.130215676271;7951.045874495068;10024.248181386425;9943.453110078943;10255.384676919371;10258.128059114984;10264.53809578567;10269.075783179513;10254.897451025507;10305.63930262441;10307.587696492132;10310.175185985103;10310.381377117359;7688.692452301929;7874.173211812792;7876.330511906494;10178.287519873611;10206.081452669257;9894.604215831358;10206.438645874474;10214.13179879711;10217.18262538995;10226.846597301046;38431.423528647094;38887.805560972294;38901.22197556033;38959.41560876561;38989.220215595815;2962.259435141215;3095.2880837407297;3241.2707140893344;3645.343838109139;3708.980030491636;29021.12936611905;29404.52977351124;29505.70494295051;29867.701322986708;30099.548506772415;3493.8427770750377;3515.2090779574646;3539.80531070791;3559.555055618048;3566.2154326048226;249593;250963;251041.99999999817;252011;252474;31584.684153158632;50332.496675033515;50970.49029509732;51041.48958510441;51046.48953510417;31480;33249;33304.50043249353;33320.50019249713;33692.326153476795;13342.799858002138;13466.057375983588;13508.459661613622;13511.527096551574;13513.054086213871;10110.39337639744;10966.506507207196;11206.663800086011;11298.943505282421;11439.599614013636;7877.448578599443;7887.171846955987;7903.762887113396;7986.880196797053;7989.400794940403;3074.969250307513;3101.7828751987595;3144.7641426893074;3148.417542754598;3150.149459645883;881.2817553693719;884.2483888694558;893.6827426263712;899.8740176375313;926.5552534783342;27409.862950685118;27683.861580691966;27941.301467463476;28021.43957120887;28470.430591388056;954.3891909178132;960.7886265021684;960.851068084448;989.9950500247453;1001.392764612786;14425.134491930517;14847.406103755944;14968.476103336548;14975.32611032506;15206.239688015556;412261;415371;415946;415971;417899;32574.67425325764;32631.67368326334;32678.836605817294;32723.50914736281;32764.836175818968;1077.4612693653173;1149.0864762513654;1183.8697743248235;1198.394810620631;1218.2812140836772;26192.4761504765;28211.589420528482;28708.85645571759;29022.419551609273;29110.12669619915;40898.79550602347;40905;41400;41430.585694142675;41447.37828932508;293278;295212;296364;297248;297852;21838.45403864916;21937.890310548344;22339.553208935406;22366.552668946857;24610.630840537047;39806.800965996146;40091;40130;40179;41251.1749765009;34778.652213478555;34909;34960.475592865616;35207.64792352044;35406.64593354137;34287.485687715205;34321.31357372888;34397.65602343944;34587.654123458444;34630.82684586561;33549.49675754817;34139.14652133716;34317.82841085779;34568;34572.481412778325;30093.09720708382;31070.689293106778;31153;31318.68681313158;31361.8431907839;23896.64155037641;23896.641550377106;24388.26835194947;24680.629790553514;24761.876190618932 13:14:03 INFO - PROCESS | 2872 | |2;jquery.html;355.5662092247457;358.98564057437693;361.0882521632877;366.042798083013;377.79032636886535;15590.766138507917;16340;17449.82550174501;17486.912565437156;17490.38783642573;16195.919020404881;16964.74552881708;17311.480655580322;17324.307027718874;17393.39123130691;4933.950660493385;5177.715225662587;5202.76587553561;5212.270282160501;5214.66104703195;3713.0160507465544;3876.7092468064866;5063.215201643733;5833.300003999526;6155.26136863577;6123.050927106306;6164.044573091156;6175.444210021097;6183.969080154593;6196.504279657639;5873.647581145124;6077.20996270482;6078.908816367736;6086.6348019119;6094.939050609503;3286.079897628668;4993.900121997576;5297.390800057966;5316.521513063843;5323.041852466555;19353.806461935343;19906.20375184991;19928.3025094121;20324.187032518683;20418.795812041837;1885.8679892407538;2007.6085163393145;2476.4923190745853;2483.180550418376;2523.116909081825;12827.358632068359;13103.08278420511;13371.33143342829;13674.93162534191;13732.107413018122;1512.5613572064087;1548.3342162869963;1555.7277476441577;1588.070978477592;1588.9205539722968;44270.335944960854;58056;65642.67178664124;66015.0097748539;67860.6606966967;9174.770630734285;9240.8613870792;9532.475713835805;9579.856302155473;9646.90353096474;12894.161879477804;13010.21938683682;13011;13047.804282935764;13065.477380904656;6974.232834388214;7024.192217894905;7212.855742885113;7266.600336981517;7315.305046020726;7025.086738723933;7076.433885289164;7122.074130363019;7239.710411583477;7242.311980361857;5990.850228744316;6002.309734380515;6011.6994150293185;6070.817875463743;6125.84685382869;1605.1011433597223;1655.5447252005795;1686.2243368050588;1703.3016463250256;1725.3616162019882;779.224671451909;782.5891407011251;813.3980854167874;863.1325517854516;876.5441970175473;15817.36730530789;16070.276837542338;16138;16165.515034548982;16659.0837503936;781.5193655901579;788.787027502571;794.3406972213049;815.9306458950937;838.6896848166095;9163.679271225608;9195.586198621078;9433.151016408556;9434.811303773886;9580.233581313478;403410;405036;409577;417559;418254;43011.5590752739;63610;68382;68621;68972;911.6444586611227;912.9406588571721;930.7626555228509;939.1172298039821;944.2115833279152;14477.033207396846;14543.200123993282;14587.978841480994;14653.853461465675;14845;33237.833810830794;34505.482417763254;35130.82434587811;35454.46818297779;36650.63349366579;42223;43985.78007109944;45496.54503454923;47208.76395618137;47955.520444795104;7378.29906158914;7743.806404839924;7823.530588164728;7824.882626760717;7941.563214023284;11257.662270131908;11278.154138439813;11932.403379831147;12447.813282800584;12926;10046.748831279276;10565.418901960158;10619.522121504397;10747.946260268649;10944.45277736094;10716.08913242352;10901.563937442414;10987.175961802737;11128.499217535069;11366.204365694322;10638.202134839763;10778.784424311627;10786.298890572089;10827.40449275266;11246.381449020382;7549.0563679540055;7669.578173200527;7723.382129429745;7787.532748035136;7923.247291507298;9356.906430935604;10462.581496740046;10648.520816563429;10700.357978521313;10747.46262686847 13:14:03 INFO - PROCESS | 2872 | |3;mootools.html;1143.554013934565;1358.0222239987206;1391.5894811030748;1426.7360538300416;1684.6125391160033;6568.507361947855;7433.442491813115;7670.194629563899;7698.191689872559;7862.96068519658;7645.044369453818;7798.805029874242;7803.336716379101;7810.1408845027;7811.648475818588;1799.8650101242395;2075.3670130610158;2144.024468866662;2152.999999999996;2180.5529866377433;2150.2259186692777;2171.272623671072;2172.055156007142;2172.837531920423;2173.7717539658347;2111.123883588309;2155.019466142909;2173.793489618484;2173.858699184556;2174.249883790098;1749.5101371615967;1812.1664034544126;1812.2479171144091;2025.4835017070552;2103.3900168950986;2085.718428012214;2117.026167962739;2131.8081372676534;2133.487962888911;2133.775953524889;7606.923930760732;7677.616119194018;7685.0777906651;7691.153973062958;7692.730754423625;4367.934480982788;4514.390557274759;4518.299663552155;4520.660950428698;4521.909561808779;2750.22993561803;2843.317603775079;2863.2841789552613;2899.1882272963603;2899.3041669999047;880.7137680253943;918.3846822628855;922.9492377919212;942.0814705661993;957.8850537935423;10053.095221430107;10286.279960402775;10287.588496460132;10298.330608510423;10370.844437333371;4050.41269015991;4070.898227544276;4079.3676980068135;4125.071858831799;4129.463169787909;8986.236169925498;9024.593893274818;9024.819503609891;9027.729168124966;9030.968032192704;4648.814047438133;4650.209464391061;4653.046125544255;4654.092451971901;4655.208614535537;3646.690031347312;4039.8284497495397;4193.1404062167185;4206.390073439334;4254.489461264606;3578.355895938704;3622.9637703622625;3692.113892665741;3721.423179407196;3755.9061023474633;1147.5811328864904;1148.7128217945515;1153.4348169397103;1153.988460115388;1160.2400427719856;794.2732399854184;798.245657853323;850.2008112374348;858.3090612057354;880.4629176202511;5068.41713202979;5123.795048198031;5149.433562308143;5311.867203319948;5350.8662283442445;830.6942512406148;840.3860430586489;868.1145231863464;875.0767939823547;881.9488191905755;3511.1270210607836;3599.4960705501253;3613.855445782192;3711.4432835074413;3756.398976163801;9241.722748317561;9432.717018489457;9489.430634161972;9592.712218633453;9595.520223988773;8823.294136469067;9200.355975081813;9207.125323094295;9470.337076404585;9508.334416590911;7036.92963070373;7146.892796608055;7185.6047917364;7206.675699593426;7231.132264128339;5308.309919710413;5318.8936221276135;5343.9198412024625;5659.236003139524;5721.713914304185;8495.405321627426;8547.188017138362;8587.141285871612;8602.956985215034;8673.392862499564;8569.614367353359;8633.35249856276;8656;8937.46375217489;8978.326625503245;5919.171316015847;6478.125453063776;6675.365840245169;6785.219699734396;6943.166819981635;7472.626368681653;7476.327130558276;7542.358899493604;7551.660175292235;7554.433417493819;6362.109304697254;6579.17760279965;6590.176227971504;6624.171978502687;6760.019797129487;6576.408123268929;6670.299618539983;6697.8325541859895;6719.428848547928;6785.4910881685055;6021.729022194099;6059.000264956233;6083.148359229623;6087.543434242538;6098.054801505774;4099.467069280974;4163.333866581333;4228.577142285747;4336.544662810359;4344.391785150145;4449.866504004885;4514.074614704044;4558.111168322145;4596.977015114903;4610.5619966104505 13:14:03 INFO - PROCESS | 2872 | |4;prototype.html;293.9015429831007;297.59081263263016;299.3922337654561;300.63623016150456;303.7767241077806;4864.781084851182;4873.658843880929;4897.828575999836;4899.289603007562;4899.926501102482;4763.166445871967;4799.64002699798;4833.613310935126;4842.322074909515;4844.6850954687925;3629.383004889162;3670.687991520724;3709.814509274539;3774.169682669822;3795;3755.136318646713;3758.924821503568;3767.3595488766973;3779.1874746929407;3782.1301100746846;3577.2666603346383;3719.423489359154;3727.6458736419995;3758.699304055669;3764.3036038333;3632.2553876455263;3751.6248375162268;3753.7560058596378;3771.7736935783664;3775.452559378902;3321.2693207494553;3325.8525808595996;3327.8502467389026;3330.9181761399127;3336.1492819331156;4704.553067458586;4724.4094488188975;4728.503507131736;4735.431748190239;4744.715317080986;4193.937090943638;4274.273373526508;4318.676099292566;4330.870073897788;4333.1766964276685;5002.82490112848;5021.422536408323;5040.294358789773;5056.443791182967;5065.645404821664;3614.8554057837655;3615.4576813477925;3619.4751760994773;3634.327649384872;3656.5063716398477;5147.562457191143;5275.630705850592;5293.708846013467;5294;5342.813001544927;3671.467637192592;3682.4476328550395;3688.280785246851;3690.2102480297035;3697.149655579232;3713.405855063177;3722.4230244312175;3725.8137093145233;3737.7944213068;3744.8876533704033;4279.379489973936;4283.593058659422;4285.785710714452;4293.034067334825;4297.183535128378;4943.355304911926;5109.795608175631;5113.386393632713;5122.3096378195105;5135.87160320995;1266.835311409511;1277.7384030266562;1278.0797825565578;1285.8971282297393;1286.2218357893528;817.5912043978011;818.6848063495478;849.6473963305159;878.767126711422;881.8456770065213;4443.466783985942;4446.377507149002;4455.460387579114;4464.6428285737065;4489.595936365743;5157.174852023733;5185.22221666753;5186.351706036746;5193.870153246124;5260.973695131576;4324.978375108104;4395.890102747457;4462.3083422068985;4509.053098849278;4511;2780.7775377969715;2800.7899407544514;2805.8877644893973;2810.339570201001;2814.9859250703616;4889.559939605452;4901.313816065754;4908.263760435963;4908.435529914105;4910.76560165124;5108.744562771846;5285.577153827685;5382.2464854920345;5397.568194544427;5432.483914028161;4920.6801557898625;4923.138450771173;4935.777889994959;4952.7771250294545;4968.366765614231;5299.33758280215;5307.893842123213;5308.495692909168;5310.840674779763;5312.468753124656;4921.416256465384;5204.386640141568;5208.661437006583;5218;5227.163653815372;4910.140725373117;4930.112579735682;4937.259411088222;4941.950580494149;4945.406551213878;3711;3711.6473934976134;3717.628237176261;3721.3673675475775;3734.495843061152;5122.974385128051;5266.473352664703;5278.392984806643;5283.2075188722;5290.338707661543;5103.234514822658;5126.359205099363;5141.948580514297;5142.922856157086;5148.330717006766;5097.898042039213;5126.820561280338;5139.563137133236;5142.897142057063;5159.355080614923;4749.976250118727;4834.274858771212;5036.244563315532;5040.949590504048;5048.873778155576;4976.552110310089;5014.323066385991;5022.799088036438;5027.572656324253;5032.6980381177245;4864.318995340726;5006.849794506171;5048.823291184938;5059.215821547666;5061.22857000047 13:14:03 INFO - PROCESS | 2872 | |5;yui.html;636.1570918532942;653.2585515439974;664.5846346033729;701.281186783547;711.6655172069126;11608.651740447778;12016.218945768518;12079.45642446091;12096.153269271155;13121.803172952414;12856.22862628243;12908.741825163515;13004.869951300485;13017.73964520709;13038;625.8748250349926;764.0449438202247;779.0962483519105;791.1060501633175;795.387551585279;786.8347646994138;803.0884945586772;803.2650125135523;803.6343463724021;803.7709252862935;840.1934143222484;845.8815765792793;846.5936350551739;846.8391005708926;847.5338563789891;647.0359164844396;791.6714563456159;822.6421506644568;829.1087081387533;830.0371568980015;612.01160126396;612.4426771637833;612.4610342898266;612.6783438694677;612.9172561704157;12786.168899021533;12817.935910320388;12823.679408014781;12832.615021549369;12836.294003829786;11496.252743571724;11903.345316007617;11918.404079795975;11978.880211197864;12320.265024895998;11402.771944561146;11545.826812597817;11575.479103440366;11623.76752464946;11644.825327620092;4102.917941641181;4148.502179738421;4149.522804877448;4165.604267594604;4171.874843754692;57430;57477.425225747626;57543;57563.71218143882;57608;8957.507337096393;9348.439093654402;9369.109934556207;9940.751481213027;10147.949260253652;16134.435294764628;16723.49829505117;16736.581585460463;17194.484165475056;17207;6949.93050069503;6960.095187625576;7106;7125.572465652078;7227.710891564278;3730.5336832895887;3761.9435708464393;3892.6691231245095;3912.139329347539;3918.490596222473;2863.3700585871075;2978.6723460419335;2982.7017298270434;2991.4316279906748;2993.3414648777234;496.74417674897455;506.1319836480454;524.307913554105;527.6174773289334;527.860117068977;582.0890306670047;586.0338564117325;588.2940471434296;598.853280946171;611.9082137679384;7797;8334.166583341617;8358.832823343499;8398.496090234605;8463.619137138843;595.1875689683551;606.4693393280879;610.4597431273355;631.7220423013952;635.8632893927828;4075.3071977763257;4108.36320370343;4160.292750232467;4219.748781905177;4257.765822879772;98161.509192455;99768;100241;100684.49657751665;103033.48483257685;88922;90149;90595.54702226447;92814;93989.53005235067;80068;81419.5929020363;83419.58290208632;83741.58129209315;84247.15752842516;7748.418868584766;7802.960985195038;7954.920450795418;8040.195980401913;8162.2653961141405;47246;47447.288290676355;47601.52398475971;48669.5133048665;49752;63101.36898630955;69526.65236673987;69552;71337.28662713307;72473.63763181362;10098.646547370807;10108;10246.487675616338;10279.588816447558;10285.9485702571;10832.512536936014;10837.187210959051;11032.558697652325;11381.146414019147;11452.541898324307;10380.221483388927;10422.218333624856;10487.632932847313;10559.419231942316;10966.451677416257;10763.246572739834;10990.230683852373;11019.504122314675;11198.496067676811;11346.20576559666;10603.522841471999;10801.297915635458;10846.566137354734;10846.945765271123;11149.108071354434;8491.83016339682;8702.216800487986;8873.73378798637;9176.862347064933;9409.952950235205;9115.772105697146;9340.579673914826;9376.578053987723;9455.669051583161;9479.810403792024 13:14:03 INFO - PROCESS | 2872 | __end_tp_report 13:14:03 INFO - PROCESS | 2872 | __start_cc_report 13:14:03 INFO - PROCESS | 2872 | _x_x_mozilla_cycle_collect,1033 13:14:03 INFO - PROCESS | 2872 | __end_cc_report 13:14:03 INFO - PROCESS | 2872 | __startTimestamp1467144843467__endTimestamp 13:14:03 INFO - PROCESS | 2872 | 13:14:03 INFO - PROCESS | 2872 | ------- Summary: start ------- 13:14:03 INFO - PROCESS | 2872 | Number of tests: 6 13:14:03 INFO - PROCESS | 2872 | 13:14:03 INFO - PROCESS | 2872 | [#0] dojo.html Cycles:165 Average:4769.25 Median:4849.85 stddev:510.53 (10.5%) stddev-sans-first:482.72 13:14:03 INFO - PROCESS | 2872 | Values: 2593.2 2625.5 2633.8 2644.7 2648.5 4626.2 4695.6 4730.5 4748.1 4826.1 4747.4 4752.7 4767.3 4809.0 4809.7 4340.2 4352.5 4419.0 4450.8 4585.8 4461.8 4504.5 4510.7 4514.9 4549.5 4332.5 4391.4 4394.1 4421.1 4452.6 4354.7 4355.0 4355.3 4465.3 4491.5 4370.9 4388.6 4389.6 4394.1 4436.2 4691.4 4769.4 4805.1 4841.4 4849.9 5234.3 5235.6 5258.6 5260.5 5262.1 5273.5 5284.6 5303.9 5306.4 5307.5 4705.4 4779.9 4824.7 4829.4 4874.9 5273.5 5279.5 5334.1 5348.2 5364.1 5110.4 5114.3 5124.7 5124.9 5129.1 5006.6 5081.8 5117.4 5119.1 5142.5 5055.8 5084.0 5093.5 5093.9 5141.4 4917.4 5090.9 5107.4 5112.7 5114.1 4395.7 4425.6 4439.0 4439.1 4495.5 3848.5 3850.2 3855.7 3899.7 3904.0 4267.3 4500.2 4503.0 4510.7 4556.4 4921.6 4937.5 5152.6 5163.0 5221.7 4449.5 4476.6 4480.0 4483.6 4522.0 4529.0 4671.4 4672.6 4675.3 4723.7 4788.1 4815.8 4822.3 4837.3 4849.7 5143.2 5145.0 5148.8 5176.3 5201.7 4656.7 4785.7 4789.8 4819.4 4884.7 5091.7 5116.4 5140.4 5146.8 5191.3 5196.1 5223.8 5226.8 5233.7 5283.1 4916.2 5005.2 5010.1 5068.3 5076.9 5049.3 5079.3 5081.5 5088.6 5122.4 5015.1 5015.2 5019.7 5038.3 5060.1 4909.5 5002.8 5056.3 5057.5 5151.0 4953.4 4966.6 4969.4 4980.3 5027.2 13:14:03 INFO - PROCESS | 2872 | 13:14:03 INFO - PROCESS | 2872 | [#1] ext.html Cycles:180 Average:45835.85 Median:32701.17 stddev:86728.11 (265.2%) stddev-sans-first:86904.71 13:14:03 INFO - PROCESS | 2872 | Values: 534.7 586.2 587.3 595.9 604.9 27019.7 40315.8 41500.4 41522.4 41634.6 39695.6 40010.4 40021.4 40076.4 40181.6 7647.2 7805.6 7907.1 7951.0 10024.2 9943.5 10255.4 10258.1 10264.5 10269.1 10254.9 10305.6 10307.6 10310.2 10310.4 7688.7 7874.2 7876.3 10178.3 10206.1 9894.6 10206.4 10214.1 10217.2 10226.8 38431.4 38887.8 38901.2 38959.4 38989.2 2962.3 3095.3 3241.3 3645.3 3709.0 29021.1 29404.5 29505.7 29867.7 30099.5 3493.8 3515.2 3539.8 3559.6 3566.2 249593.0 250963.0 251042.0 252011.0 252474.0 31584.7 50332.5 50970.5 51041.5 51046.5 31480.0 33249.0 33304.5 33320.5 33692.3 13342.8 13466.1 13508.5 13511.5 13513.1 10110.4 10966.5 11206.7 11298.9 11439.6 7877.4 7887.2 7903.8 7986.9 7989.4 3075.0 3101.8 3144.8 3148.4 3150.1 881.3 884.2 893.7 899.9 926.6 27409.9 27683.9 27941.3 28021.4 28470.4 954.4 960.8 960.9 990.0 1001.4 14425.1 14847.4 14968.5 14975.3 15206.2 412261.0 415371.0 415946.0 415971.0 417899.0 32574.7 32631.7 32678.8 32723.5 32764.8 1077.5 1149.1 1183.9 1198.4 1218.3 26192.5 28211.6 28708.9 29022.4 29110.1 40898.8 40905.0 41400.0 41430.6 41447.4 293278.0 295212.0 296364.0 297248.0 297852.0 21838.5 21937.9 22339.6 22366.6 24610.6 39806.8 40091.0 40130.0 40179.0 41251.2 34778.7 34909.0 34960.5 35207.6 35406.6 34287.5 34321.3 34397.7 34587.7 34630.8 33549.5 34139.1 34317.8 34568.0 34572.5 30093.1 31070.7 31153.0 31318.7 31361.8 23896.6 23896.6 24388.3 24680.6 24761.9 13:14:03 INFO - PROCESS | 2872 | 13:14:03 INFO - PROCESS | 2872 | [#2] jquery.html Cycles:180 Average:24167.77 Median:417906.50 stddev:67218.87 (16.1%) stddev-sans-first:67383.65 13:14:03 INFO - PROCESS | 2872 | Values: 355.6 359.0 361.1 366.0 377.8 15590.8 16340.0 17449.8 17486.9 17490.4 16195.9 16964.7 17311.5 17324.3 17393.4 4934.0 5177.7 5202.8 5212.3 5214.7 3713.0 3876.7 5063.2 5833.3 6155.3 6123.1 6164.0 6175.4 6184.0 6196.5 5873.6 6077.2 6078.9 6086.6 6094.9 3286.1 4993.9 5297.4 5316.5 5323.0 19353.8 19906.2 19928.3 20324.2 20418.8 1885.9 2007.6 2476.5 2483.2 2523.1 12827.4 13103.1 13371.3 13674.9 13732.1 1512.6 1548.3 1555.7 1588.1 1588.9 44270.3 58056.0 65642.7 66015.0 67860.7 9174.8 9240.9 9532.5 9579.9 9646.9 12894.2 13010.2 13011.0 13047.8 13065.5 6974.2 7024.2 7212.9 7266.6 7315.3 7025.1 7076.4 7122.1 7239.7 7242.3 5990.9 6002.3 6011.7 6070.8 6125.8 1605.1 1655.5 1686.2 1703.3 1725.4 779.2 782.6 813.4 863.1 876.5 15817.4 16070.3 16138.0 16165.5 16659.1 781.5 788.8 794.3 815.9 838.7 9163.7 9195.6 9433.2 9434.8 9580.2 403410.0 405036.0 409577.0 417559.0 418254.0 43011.6 63610.0 68382.0 68621.0 68972.0 911.6 912.9 930.8 939.1 944.2 14477.0 14543.2 14588.0 14653.9 14845.0 33237.8 34505.5 35130.8 35454.5 36650.6 42223.0 43985.8 45496.5 47208.8 47955.5 7378.3 7743.8 7823.5 7824.9 7941.6 11257.7 11278.2 11932.4 12447.8 12926.0 10046.7 10565.4 10619.5 10747.9 10944.5 10716.1 10901.6 10987.2 11128.5 11366.2 10638.2 10778.8 10786.3 10827.4 11246.4 7549.1 7669.6 7723.4 7787.5 7923.2 9356.9 10462.6 10648.5 10700.4 10747.5 13:14:03 INFO - PROCESS | 2872 | 13:14:03 INFO - PROCESS | 2872 | [#3] mootools.html Cycles:180 Average:5036.33 Median:5331.41 stddev:2811.17 (52.7%) stddev-sans-first:2803.83 13:14:03 INFO - PROCESS | 2872 | Values: 1143.6 1358.0 1391.6 1426.7 1684.6 6568.5 7433.4 7670.2 7698.2 7863.0 7645.0 7798.8 7803.3 7810.1 7811.6 1799.9 2075.4 2144.0 2153.0 2180.6 2150.2 2171.3 2172.1 2172.8 2173.8 2111.1 2155.0 2173.8 2173.9 2174.2 1749.5 1812.2 1812.2 2025.5 2103.4 2085.7 2117.0 2131.8 2133.5 2133.8 7606.9 7677.6 7685.1 7691.2 7692.7 4367.9 4514.4 4518.3 4520.7 4521.9 2750.2 2843.3 2863.3 2899.2 2899.3 880.7 918.4 922.9 942.1 957.9 10053.1 10286.3 10287.6 10298.3 10370.8 4050.4 4070.9 4079.4 4125.1 4129.5 8986.2 9024.6 9024.8 9027.7 9031.0 4648.8 4650.2 4653.0 4654.1 4655.2 3646.7 4039.8 4193.1 4206.4 4254.5 3578.4 3623.0 3692.1 3721.4 3755.9 1147.6 1148.7 1153.4 1154.0 1160.2 794.3 798.2 850.2 858.3 880.5 5068.4 5123.8 5149.4 5311.9 5350.9 830.7 840.4 868.1 875.1 881.9 3511.1 3599.5 3613.9 3711.4 3756.4 9241.7 9432.7 9489.4 9592.7 9595.5 8823.3 9200.4 9207.1 9470.3 9508.3 7036.9 7146.9 7185.6 7206.7 7231.1 5308.3 5318.9 5343.9 5659.2 5721.7 8495.4 8547.2 8587.1 8603.0 8673.4 8569.6 8633.4 8656.0 8937.5 8978.3 5919.2 6478.1 6675.4 6785.2 6943.2 7472.6 7476.3 7542.4 7551.7 7554.4 6362.1 6579.2 6590.2 6624.2 6760.0 6576.4 6670.3 6697.8 6719.4 6785.5 6021.7 6059.0 6083.1 6087.5 6098.1 4099.5 4163.3 4228.6 4336.5 4344.4 4449.9 4514.1 4558.1 4597.0 4610.6 13:14:03 INFO - PROCESS | 2872 | 13:14:03 INFO - PROCESS | 2872 | [#4] prototype.html Cycles:180 Average:4216.44 Median:4843.50 stddev:1231.23 (25.4%) stddev-sans-first:1198.96 13:14:03 INFO - PROCESS | 2872 | Values: 293.9 297.6 299.4 300.6 303.8 4864.8 4873.7 4897.8 4899.3 4899.9 4763.2 4799.6 4833.6 4842.3 4844.7 3629.4 3670.7 3709.8 3774.2 3795.0 3755.1 3758.9 3767.4 3779.2 3782.1 3577.3 3719.4 3727.6 3758.7 3764.3 3632.3 3751.6 3753.8 3771.8 3775.5 3321.3 3325.9 3327.9 3330.9 3336.1 4704.6 4724.4 4728.5 4735.4 4744.7 4193.9 4274.3 4318.7 4330.9 4333.2 5002.8 5021.4 5040.3 5056.4 5065.6 3614.9 3615.5 3619.5 3634.3 3656.5 5147.6 5275.6 5293.7 5294.0 5342.8 3671.5 3682.4 3688.3 3690.2 3697.1 3713.4 3722.4 3725.8 3737.8 3744.9 4279.4 4283.6 4285.8 4293.0 4297.2 4943.4 5109.8 5113.4 5122.3 5135.9 1266.8 1277.7 1278.1 1285.9 1286.2 817.6 818.7 849.6 878.8 881.8 4443.5 4446.4 4455.5 4464.6 4489.6 5157.2 5185.2 5186.4 5193.9 5261.0 4325.0 4395.9 4462.3 4509.1 4511.0 2780.8 2800.8 2805.9 2810.3 2815.0 4889.6 4901.3 4908.3 4908.4 4910.8 5108.7 5285.6 5382.2 5397.6 5432.5 4920.7 4923.1 4935.8 4952.8 4968.4 5299.3 5307.9 5308.5 5310.8 5312.5 4921.4 5204.4 5208.7 5218.0 5227.2 4910.1 4930.1 4937.3 4942.0 4945.4 3711.0 3711.6 3717.6 3721.4 3734.5 5123.0 5266.5 5278.4 5283.2 5290.3 5103.2 5126.4 5141.9 5142.9 5148.3 5097.9 5126.8 5139.6 5142.9 5159.4 4750.0 4834.3 5036.2 5040.9 5048.9 4976.6 5014.3 5022.8 5027.6 5032.7 4864.3 5006.8 5048.8 5059.2 5061.2 13:14:03 INFO - PROCESS | 2872 | 13:14:03 INFO - PROCESS | 2872 | [#5] yui.html Cycles:180 Average:18155.19 Median:57510.21 stddev:26907.81 (46.8%) stddev-sans-first:26951.14 13:14:03 INFO - PROCESS | 2872 | Values: 636.2 653.3 664.6 701.3 711.7 11608.7 12016.2 12079.5 12096.2 13121.8 12856.2 12908.7 13004.9 13017.7 13038.0 625.9 764.0 779.1 791.1 795.4 786.8 803.1 803.3 803.6 803.8 840.2 845.9 846.6 846.8 847.5 647.0 791.7 822.6 829.1 830.0 612.0 612.4 612.5 612.7 612.9 12786.2 12817.9 12823.7 12832.6 12836.3 11496.3 11903.3 11918.4 11978.9 12320.3 11402.8 11545.8 11575.5 11623.8 11644.8 4102.9 4148.5 4149.5 4165.6 4171.9 57430.0 57477.4 57543.0 57563.7 57608.0 8957.5 9348.4 9369.1 9940.8 10147.9 16134.4 16723.5 16736.6 17194.5 17207.0 6949.9 6960.1 7106.0 7125.6 7227.7 3730.5 3761.9 3892.7 3912.1 3918.5 2863.4 2978.7 2982.7 2991.4 2993.3 496.7 506.1 524.3 527.6 527.9 582.1 586.0 588.3 598.9 611.9 7797.0 8334.2 8358.8 8398.5 8463.6 595.2 606.5 610.5 631.7 635.9 4075.3 4108.4 4160.3 4219.7 4257.8 98161.5 99768.0 100241.0 100684.5 103033.5 88922.0 90149.0 90595.5 92814.0 93989.5 80068.0 81419.6 83419.6 83741.6 84247.2 7748.4 7803.0 7954.9 8040.2 8162.3 47246.0 47447.3 47601.5 48669.5 49752.0 63101.4 69526.7 69552.0 71337.3 72473.6 10098.6 10108.0 10246.5 10279.6 10285.9 10832.5 10837.2 11032.6 11381.1 11452.5 10380.2 10422.2 10487.6 10559.4 10966.5 10763.2 10990.2 11019.5 11198.5 11346.2 10603.5 10801.3 10846.6 10846.9 11149.1 8491.8 8702.2 8873.7 9176.9 9410.0 9115.8 9340.6 9376.6 9455.7 9479.8 13:14:03 INFO - PROCESS | 2872 | -------- Summary: end -------- 13:14:03 INFO - PROCESS | 2872 | 13:14:04 INFO - TEST-INFO | 2872: exit 0 13:14:04 INFO - TEST-OK | dromaeo_css | took 1120068ms 13:14:04 INFO - TEST-START | kraken 13:14:04 INFO - operating with platform_type : linux_ 13:14:04 INFO - Initialising browser for kraken test... 13:14:04 INFO - TEST-INFO | started process 3071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMKR9Rb/profile http://localhost:48065/getInfo.html) 13:14:08 INFO - PROCESS | 3071 | __metrics Screen width/height:1600/1200 13:14:08 INFO - PROCESS | 3071 | colorDepth:24 13:14:08 INFO - PROCESS | 3071 | Browser inner width/height: 1024/697 13:14:08 INFO - PROCESS | 3071 | __metrics 13:14:09 INFO - PROCESS | 3071 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:14:10 INFO - TEST-INFO | 3071: exit 0 13:14:10 INFO - Browser initialized. 13:14:10 INFO - Running cycle 1/1 for kraken test... 13:14:10 INFO - TEST-INFO | started process 3151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMKR9Rb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:22 INFO - PROCESS | 3151 | RSS: Main: 158527488 13:14:22 INFO - PROCESS | 3151 | 13:14:24 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48065/tests/kraken/driver.html?testName=audio-beat-detection) 13:14:25 INFO - PROCESS | 3151 | RSS: Main: 216506368 13:14:25 INFO - PROCESS | 3151 | 13:14:28 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48065/tests/kraken/driver.html?testName=audio-dft) 13:14:29 INFO - PROCESS | 3151 | RSS: Main: 204648448 13:14:29 INFO - PROCESS | 3151 | 13:14:32 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48065/tests/kraken/driver.html?testName=audio-fft) 13:14:33 INFO - PROCESS | 3151 | RSS: Main: 270807040 13:14:33 INFO - PROCESS | 3151 | 13:14:35 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48065/tests/kraken/driver.html?testName=audio-oscillator) 13:14:35 INFO - PROCESS | 3151 | RSS: Main: 180862976 13:14:35 INFO - PROCESS | 3151 | 13:14:38 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:38 INFO - PROCESS | 3151 | RSS: Main: 184713216 13:14:38 INFO - PROCESS | 3151 | 13:14:41 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48065/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:42 INFO - PROCESS | 3151 | RSS: Main: 221077504 13:14:42 INFO - PROCESS | 3151 | 13:14:46 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48065/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:46 INFO - PROCESS | 3151 | RSS: Main: 216555520 13:14:46 INFO - PROCESS | 3151 | 13:14:49 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48065/tests/kraken/driver.html?testName=json-parse-financial) 13:14:50 INFO - PROCESS | 3151 | RSS: Main: 219426816 13:14:50 INFO - PROCESS | 3151 | 13:14:51 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:52 INFO - PROCESS | 3151 | RSS: Main: 205725696 13:14:52 INFO - PROCESS | 3151 | 13:14:54 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48065/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:54 INFO - PROCESS | 3151 | RSS: Main: 209674240 13:14:54 INFO - PROCESS | 3151 | 13:14:57 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:57 INFO - PROCESS | 3151 | RSS: Main: 217346048 13:14:57 INFO - PROCESS | 3151 | 13:15:00 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:15:01 INFO - PROCESS | 3151 | RSS: Main: 220946432 13:15:01 INFO - PROCESS | 3151 | 13:15:04 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:15:04 INFO - PROCESS | 3151 | RSS: Main: 222453760 13:15:04 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | Cycle 1(1): loaded http://localhost:48065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48065/tests/kraken/driver.html?testName=ai-astar) 13:15:06 INFO - PROCESS | 3151 | RSS: Main: 265560064 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | __start_tp_report 13:15:06 INFO - PROCESS | 3151 | _x_x_mozilla_page_load 13:15:06 INFO - PROCESS | 3151 | _x_x_mozilla_page_load_details 13:15:06 INFO - PROCESS | 3151 | |i|pagename|runs| 13:15:06 INFO - PROCESS | 3151 | |0;ai-astar;104;114;112;114;113;113;111;113;113;113 13:15:06 INFO - PROCESS | 3151 | |1;audio-beat-detection;158;130;138;205;131;155;168;131;182;135 13:15:06 INFO - PROCESS | 3151 | |2;audio-dft;161;162;160;161;162;162;162;161;161;160 13:15:06 INFO - PROCESS | 3151 | |3;audio-fft;75;77;76;113;76;77;75;75;108;76 13:15:06 INFO - PROCESS | 3151 | |4;audio-oscillator;87;86;119;85;85;85;118;85;85;134 13:15:06 INFO - PROCESS | 3151 | |5;imaging-gaussian-blur;116;117;116;118;117;116;117;116;117;116 13:15:06 INFO - PROCESS | 3151 | |6;imaging-darkroom;147;147;146;146;147;147;147;147;146;146 13:15:06 INFO - PROCESS | 3151 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 13:15:06 INFO - PROCESS | 3151 | |8;json-parse-financial;64;65;65;64;67;66;64;65;66;64 13:15:06 INFO - PROCESS | 3151 | |9;json-stringify-tinderbox;64;65;65;64;65;64;65;66;65;65 13:15:06 INFO - PROCESS | 3151 | |10;stanford-crypto-aes;83;81;83;82;82;84;84;89;115;84 13:15:06 INFO - PROCESS | 3151 | |11;stanford-crypto-ccm;133;129;138;131;132;127;142;133;144;132 13:15:06 INFO - PROCESS | 3151 | |12;stanford-crypto-pbkdf2;171;170;168;168;173;172;168;165;173;166 13:15:06 INFO - PROCESS | 3151 | |13;stanford-crypto-sha256-iterative;66;66;67;66;67;65;66;66;69;66 13:15:06 INFO - PROCESS | 3151 | __end_tp_report 13:15:06 INFO - PROCESS | 3151 | __start_cc_report 13:15:06 INFO - PROCESS | 3151 | _x_x_mozilla_cycle_collect,1873 13:15:06 INFO - PROCESS | 3151 | __end_cc_report 13:15:06 INFO - PROCESS | 3151 | __startTimestamp1467144906745__endTimestamp 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | ------- Summary: start ------- 13:15:06 INFO - PROCESS | 3151 | Number of tests: 14 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 13:15:06 INFO - PROCESS | 3151 | Values: 104.0 114.0 112.0 114.0 113.0 113.0 111.0 113.0 113.0 113.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:156.50 stddev:25.48 (16.3%) stddev-sans-first:26.97 13:15:06 INFO - PROCESS | 3151 | Values: 158.0 130.0 138.0 205.0 131.0 155.0 168.0 131.0 182.0 135.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 13:15:06 INFO - PROCESS | 3151 | Values: 161.0 162.0 160.0 161.0 162.0 162.0 162.0 161.0 161.0 160.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:14.67 (19.3%) stddev-sans-first:15.28 13:15:06 INFO - PROCESS | 3151 | Values: 75.0 77.0 76.0 113.0 76.0 77.0 75.0 75.0 108.0 76.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:18.96 (22.3%) stddev-sans-first:19.77 13:15:06 INFO - PROCESS | 3151 | Values: 87.0 86.0 119.0 85.0 85.0 85.0 118.0 85.0 85.0 134.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 13:15:06 INFO - PROCESS | 3151 | Values: 116.0 117.0 116.0 118.0 117.0 116.0 117.0 116.0 117.0 116.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:15:06 INFO - PROCESS | 3151 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 146.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:15:06 INFO - PROCESS | 3151 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.05 (1.6%) stddev-sans-first:1.05 13:15:06 INFO - PROCESS | 3151 | Values: 64.0 65.0 65.0 64.0 67.0 66.0 64.0 65.0 66.0 64.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 13:15:06 INFO - PROCESS | 3151 | Values: 64.0 65.0 65.0 64.0 65.0 64.0 65.0 66.0 65.0 65.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:83.50 stddev:10.18 (12.2%) stddev-sans-first:10.71 13:15:06 INFO - PROCESS | 3151 | Values: 83.0 81.0 83.0 82.0 82.0 84.0 84.0 89.0 115.0 84.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:133.00 stddev:5.51 (4.1%) stddev-sans-first:5.83 13:15:06 INFO - PROCESS | 3151 | Values: 133.0 129.0 138.0 131.0 132.0 127.0 142.0 133.0 144.0 132.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:170.50 stddev:2.84 (1.7%) stddev-sans-first:2.95 13:15:06 INFO - PROCESS | 3151 | Values: 171.0 170.0 168.0 168.0 173.0 172.0 168.0 165.0 173.0 166.0 13:15:06 INFO - PROCESS | 3151 | 13:15:06 INFO - PROCESS | 3151 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 13:15:06 INFO - PROCESS | 3151 | Values: 66.0 66.0 67.0 66.0 67.0 65.0 66.0 66.0 69.0 66.0 13:15:06 INFO - PROCESS | 3151 | -------- Summary: end -------- 13:15:06 INFO - PROCESS | 3151 | 13:15:07 INFO - TEST-INFO | 3151: exit 0 13:15:07 INFO - TEST-OK | kraken | took 63498ms 13:15:07 INFO - SUITE-END | took 1183s 13:15:07 INFO - Completed test suite (00:19:43) 13:15:07 INFO - javascript benchmark 13:15:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.157223902232, 2625.5405304071783, 2633.8024648151386, 2644.7355264473554, 2648.536506111431, 4626.190416677085, 4695.624350051996, 4730.4559975602815, 4748.050389922017, 4826.0830442216, 4747.430308363001, 4752.691075080117, 4767.284907263904, 4808.975955120228, 4809.687370320927, 4340.240457919867, 4352.455943007124, 4419.027813880957, 4450.755208463534, 4585.79363928624, 4461.754603496806, 4504.459464864204, 4510.684252102355, 4514.864554063367, 4549.476810166823, 4332.458442694648, 4391.429114215131, 4394.055278115221, 4421.137878113769, 4452.554744525554, 4354.673399495051, 4355.041890784022, 4355.303151495746, 4465.307877279027, 4491.483479399878, 4370.8907277318, 4388.626966707834, 4389.582989615981, 4394.123998296242, 4436.245838207513, 4691.437027556681, 4769.3799806025345, 4805.063012712522, 4841.370621819176, 4849.854504364875, 5234.319538460014, 5235.633505654568, 5258.6318957672975, 5260.500252476008, 5262.0791361511965, 5273.499017593323, 5284.550813180885, 5303.867403314909, 5306.3632364116165, 5307.495787900143, 4705.388299521041, 4779.904401911942, 4824.6863953842885, 4829.420469543607, 4874.853754387339, 5273.499017593323, 5279.524842764093, 5334.146536554133, 5348.171033489815, 5364.061289274361, 5110.437851836295, 5114.3095682083185, 5124.666896651705, 5124.897502049938, 5129.051125541787, 5006.624503162205, 5081.8475445736685, 5117.385913690381, 5119.10415677255, 5142.460041695643, 5055.848324550269, 5083.974580127076, 5093.541581257705, 5093.8726531837, 5141.434442211354, 4917.409910810654, 5090.872728181825, 5107.412647545506, 5112.667676601009, 5114.105031619451, 4395.714278571946, 4425.623821975104, 4438.955610443919, 4439.089986552749, 4495.483019452805, 3848.499695039627, 3850.1914597934747, 3855.691544676419, 3899.707521935866, 3904.0, 4267.317229243306, 4500.234960056799, 4502.986827963682, 4510.684252102387, 4556.430446194226, 4921.581665558396, 4937.481564435682, 5152.587792976553, 5162.9741851291255, 5221.686698798084, 4449.466064072332, 4476.597106260452, 4479.955200447954, 4483.596476317147, 4521.954780452219, 4529.0, 4671.416072990876, 4672.57946784791, 4675.275332323496, 4723.716577005322, 4788.1381351356395, 4815.831445899376, 4822.252550854623, 4837.3227748116, 4849.709017458964, 5143.2285157225215, 5145.048166089286, 5148.845534633967, 5176.327077479904, 5201.661891977009, 4656.697314674535, 4785.712857228577, 4789.760511974457, 4819.397575303087, 4884.731339776346, 5091.694498330112, 5116.411612664591, 5140.3831540215415, 5146.819861304836, 5191.32512773337, 5196.116660167705, 5223.791048358175, 5226.843194704165, 5233.659812112201, 5283.075461794094, 4916.188828843344, 5005.249212618136, 5010.123228435083, 5068.2904393384215, 5076.898462030813, 5049.2930989660745, 5079.263506791421, 5081.466446023114, 5088.643794934319, 5122.385313762373, 5015.122353588181, 5015.247712843103, 5019.67372120811, 5038.319826823332, 5060.139776237975, 4909.533594308535, 5002.849914502571, 5056.266841308064, 5057.46896575869, 5151.0, 4953.380827396575, 4966.602671786321, 4969.35398398206, 4980.27785971025, 5027.195648696191], "value": 4735.68962961223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.6921410891088, 586.1530089021364, 587.333376617539, 595.8838026584813, 604.921360223171, 27019.729802701968, 40315.798421007894, 41500.37749433761, 41522.37716434256, 41634.58365416352, 39695.60304396955, 40010.399844002364, 40021.39967900484, 40076.39885401714, 40181.59818401815, 7647.235276472336, 7805.6487458064385, 7907.130215676271, 7951.045874495068, 10024.248181386425, 9943.453110078943, 10255.384676919371, 10258.128059114984, 10264.53809578567, 10269.075783179513, 10254.897451025507, 10305.63930262441, 10307.587696492132, 10310.175185985103, 10310.381377117359, 7688.692452301929, 7874.173211812792, 7876.330511906494, 10178.287519873611, 10206.081452669257, 9894.604215831358, 10206.438645874474, 10214.13179879711, 10217.18262538995, 10226.846597301046, 38431.423528647094, 38887.805560972294, 38901.22197556033, 38959.41560876561, 38989.220215595815, 2962.259435141215, 3095.2880837407297, 3241.2707140893344, 3645.343838109139, 3708.980030491636, 29021.12936611905, 29404.52977351124, 29505.70494295051, 29867.701322986708, 30099.548506772415, 3493.8427770750377, 3515.2090779574646, 3539.80531070791, 3559.555055618048, 3566.2154326048226, 249593.0, 250963.0, 251041.99999999817, 252011.0, 252474.0, 31584.684153158632, 50332.496675033515, 50970.49029509732, 51041.48958510441, 51046.48953510417, 31480.0, 33249.0, 33304.50043249353, 33320.50019249713, 33692.326153476795, 13342.799858002138, 13466.057375983588, 13508.459661613622, 13511.527096551574, 13513.054086213871, 10110.39337639744, 10966.506507207196, 11206.663800086011, 11298.943505282421, 11439.599614013636, 7877.448578599443, 7887.171846955987, 7903.762887113396, 7986.880196797053, 7989.400794940403, 3074.969250307513, 3101.7828751987595, 3144.7641426893074, 3148.417542754598, 3150.149459645883, 881.2817553693719, 884.2483888694558, 893.6827426263712, 899.8740176375313, 926.5552534783342, 27409.862950685118, 27683.861580691966, 27941.301467463476, 28021.43957120887, 28470.430591388056, 954.3891909178132, 960.7886265021684, 960.851068084448, 989.9950500247453, 1001.392764612786, 14425.134491930517, 14847.406103755944, 14968.476103336548, 14975.32611032506, 15206.239688015556, 412261.0, 415371.0, 415946.0, 415971.0, 417899.0, 32574.67425325764, 32631.67368326334, 32678.836605817294, 32723.50914736281, 32764.836175818968, 1077.4612693653173, 1149.0864762513654, 1183.8697743248235, 1198.394810620631, 1218.2812140836772, 26192.4761504765, 28211.589420528482, 28708.85645571759, 29022.419551609273, 29110.12669619915, 40898.79550602347, 40905.0, 41400.0, 41430.585694142675, 41447.37828932508, 293278.0, 295212.0, 296364.0, 297248.0, 297852.0, 21838.45403864916, 21937.890310548344, 22339.553208935406, 22366.552668946857, 24610.630840537047, 39806.800965996146, 40091.0, 40130.0, 40179.0, 41251.1749765009, 34778.652213478555, 34909.0, 34960.475592865616, 35207.64792352044, 35406.64593354137, 34287.485687715205, 34321.31357372888, 34397.65602343944, 34587.654123458444, 34630.82684586561, 33549.49675754817, 34139.14652133716, 34317.82841085779, 34568.0, 34572.481412778325, 30093.09720708382, 31070.689293106778, 31153.0, 31318.68681313158, 31361.8431907839, 23896.64155037641, 23896.641550377106, 24388.26835194947, 24680.629790553514, 24761.876190618932], "value": 16550.624934173054, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.5662092247457, 358.98564057437693, 361.0882521632877, 366.042798083013, 377.79032636886535, 15590.766138507917, 16340.0, 17449.82550174501, 17486.912565437156, 17490.38783642573, 16195.919020404881, 16964.74552881708, 17311.480655580322, 17324.307027718874, 17393.39123130691, 4933.950660493385, 5177.715225662587, 5202.76587553561, 5212.270282160501, 5214.66104703195, 3713.0160507465544, 3876.7092468064866, 5063.215201643733, 5833.300003999526, 6155.26136863577, 6123.050927106306, 6164.044573091156, 6175.444210021097, 6183.969080154593, 6196.504279657639, 5873.647581145124, 6077.20996270482, 6078.908816367736, 6086.6348019119, 6094.939050609503, 3286.079897628668, 4993.900121997576, 5297.390800057966, 5316.521513063843, 5323.041852466555, 19353.806461935343, 19906.20375184991, 19928.3025094121, 20324.187032518683, 20418.795812041837, 1885.8679892407538, 2007.6085163393145, 2476.4923190745853, 2483.180550418376, 2523.116909081825, 12827.358632068359, 13103.08278420511, 13371.33143342829, 13674.93162534191, 13732.107413018122, 1512.5613572064087, 1548.3342162869963, 1555.7277476441577, 1588.070978477592, 1588.9205539722968, 44270.335944960854, 58056.0, 65642.67178664124, 66015.0097748539, 67860.6606966967, 9174.770630734285, 9240.8613870792, 9532.475713835805, 9579.856302155473, 9646.90353096474, 12894.161879477804, 13010.21938683682, 13011.0, 13047.804282935764, 13065.477380904656, 6974.232834388214, 7024.192217894905, 7212.855742885113, 7266.600336981517, 7315.305046020726, 7025.086738723933, 7076.433885289164, 7122.074130363019, 7239.710411583477, 7242.311980361857, 5990.850228744316, 6002.309734380515, 6011.6994150293185, 6070.817875463743, 6125.84685382869, 1605.1011433597223, 1655.5447252005795, 1686.2243368050588, 1703.3016463250256, 1725.3616162019882, 779.224671451909, 782.5891407011251, 813.3980854167874, 863.1325517854516, 876.5441970175473, 15817.36730530789, 16070.276837542338, 16138.0, 16165.515034548982, 16659.0837503936, 781.5193655901579, 788.787027502571, 794.3406972213049, 815.9306458950937, 838.6896848166095, 9163.679271225608, 9195.586198621078, 9433.151016408556, 9434.811303773886, 9580.233581313478, 403410.0, 405036.0, 409577.0, 417559.0, 418254.0, 43011.5590752739, 63610.0, 68382.0, 68621.0, 68972.0, 911.6444586611227, 912.9406588571721, 930.7626555228509, 939.1172298039821, 944.2115833279152, 14477.033207396846, 14543.200123993282, 14587.978841480994, 14653.853461465675, 14845.0, 33237.833810830794, 34505.482417763254, 35130.82434587811, 35454.46818297779, 36650.63349366579, 42223.0, 43985.78007109944, 45496.54503454923, 47208.76395618137, 47955.520444795104, 7378.29906158914, 7743.806404839924, 7823.530588164728, 7824.882626760717, 7941.563214023284, 11257.662270131908, 11278.154138439813, 11932.403379831147, 12447.813282800584, 12926.0, 10046.748831279276, 10565.418901960158, 10619.522121504397, 10747.946260268649, 10944.45277736094, 10716.08913242352, 10901.563937442414, 10987.175961802737, 11128.499217535069, 11366.204365694322, 10638.202134839763, 10778.784424311627, 10786.298890572089, 10827.40449275266, 11246.381449020382, 7549.0563679540055, 7669.578173200527, 7723.382129429745, 7787.532748035136, 7923.247291507298, 9356.906430935604, 10462.581496740046, 10648.520816563429, 10700.357978521313, 10747.46262686847], "value": 8232.842803990912, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1143.554013934565, 1358.0222239987206, 1391.5894811030748, 1426.7360538300416, 1684.6125391160033, 6568.507361947855, 7433.442491813115, 7670.194629563899, 7698.191689872559, 7862.96068519658, 7645.044369453818, 7798.805029874242, 7803.336716379101, 7810.1408845027, 7811.648475818588, 1799.8650101242395, 2075.3670130610158, 2144.024468866662, 2152.999999999996, 2180.5529866377433, 2150.2259186692777, 2171.272623671072, 2172.055156007142, 2172.837531920423, 2173.7717539658347, 2111.123883588309, 2155.019466142909, 2173.793489618484, 2173.858699184556, 2174.249883790098, 1749.5101371615967, 1812.1664034544126, 1812.2479171144091, 2025.4835017070552, 2103.3900168950986, 2085.718428012214, 2117.026167962739, 2131.8081372676534, 2133.487962888911, 2133.775953524889, 7606.923930760732, 7677.616119194018, 7685.0777906651, 7691.153973062958, 7692.730754423625, 4367.934480982788, 4514.390557274759, 4518.299663552155, 4520.660950428698, 4521.909561808779, 2750.22993561803, 2843.317603775079, 2863.2841789552613, 2899.1882272963603, 2899.3041669999047, 880.7137680253943, 918.3846822628855, 922.9492377919212, 942.0814705661993, 957.8850537935423, 10053.095221430107, 10286.279960402775, 10287.588496460132, 10298.330608510423, 10370.844437333371, 4050.41269015991, 4070.898227544276, 4079.3676980068135, 4125.071858831799, 4129.463169787909, 8986.236169925498, 9024.593893274818, 9024.819503609891, 9027.729168124966, 9030.968032192704, 4648.814047438133, 4650.209464391061, 4653.046125544255, 4654.092451971901, 4655.208614535537, 3646.690031347312, 4039.8284497495397, 4193.1404062167185, 4206.390073439334, 4254.489461264606, 3578.355895938704, 3622.9637703622625, 3692.113892665741, 3721.423179407196, 3755.9061023474633, 1147.5811328864904, 1148.7128217945515, 1153.4348169397103, 1153.988460115388, 1160.2400427719856, 794.2732399854184, 798.245657853323, 850.2008112374348, 858.3090612057354, 880.4629176202511, 5068.41713202979, 5123.795048198031, 5149.433562308143, 5311.867203319948, 5350.8662283442445, 830.6942512406148, 840.3860430586489, 868.1145231863464, 875.0767939823547, 881.9488191905755, 3511.1270210607836, 3599.4960705501253, 3613.855445782192, 3711.4432835074413, 3756.398976163801, 9241.722748317561, 9432.717018489457, 9489.430634161972, 9592.712218633453, 9595.520223988773, 8823.294136469067, 9200.355975081813, 9207.125323094295, 9470.337076404585, 9508.334416590911, 7036.92963070373, 7146.892796608055, 7185.6047917364, 7206.675699593426, 7231.132264128339, 5308.309919710413, 5318.8936221276135, 5343.9198412024625, 5659.236003139524, 5721.713914304185, 8495.405321627426, 8547.188017138362, 8587.141285871612, 8602.956985215034, 8673.392862499564, 8569.614367353359, 8633.35249856276, 8656.0, 8937.46375217489, 8978.326625503245, 5919.171316015847, 6478.125453063776, 6675.365840245169, 6785.219699734396, 6943.166819981635, 7472.626368681653, 7476.327130558276, 7542.358899493604, 7551.660175292235, 7554.433417493819, 6362.109304697254, 6579.17760279965, 6590.176227971504, 6624.171978502687, 6760.019797129487, 6576.408123268929, 6670.299618539983, 6697.8325541859895, 6719.428848547928, 6785.4910881685055, 6021.729022194099, 6059.000264956233, 6083.148359229623, 6087.543434242538, 6098.054801505774, 4099.467069280974, 4163.333866581333, 4228.577142285747, 4336.544662810359, 4344.391785150145, 4449.866504004885, 4514.074614704044, 4558.111168322145, 4596.977015114903, 4610.5619966104505], "value": 4055.7741272920453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.9015429831007, 297.59081263263016, 299.3922337654561, 300.63623016150456, 303.7767241077806, 4864.781084851182, 4873.658843880929, 4897.828575999836, 4899.289603007562, 4899.926501102482, 4763.166445871967, 4799.64002699798, 4833.613310935126, 4842.322074909515, 4844.6850954687925, 3629.383004889162, 3670.687991520724, 3709.814509274539, 3774.169682669822, 3795.0, 3755.136318646713, 3758.924821503568, 3767.3595488766973, 3779.1874746929407, 3782.1301100746846, 3577.2666603346383, 3719.423489359154, 3727.6458736419995, 3758.699304055669, 3764.3036038333, 3632.2553876455263, 3751.6248375162268, 3753.7560058596378, 3771.7736935783664, 3775.452559378902, 3321.2693207494553, 3325.8525808595996, 3327.8502467389026, 3330.9181761399127, 3336.1492819331156, 4704.553067458586, 4724.4094488188975, 4728.503507131736, 4735.431748190239, 4744.715317080986, 4193.937090943638, 4274.273373526508, 4318.676099292566, 4330.870073897788, 4333.1766964276685, 5002.82490112848, 5021.422536408323, 5040.294358789773, 5056.443791182967, 5065.645404821664, 3614.8554057837655, 3615.4576813477925, 3619.4751760994773, 3634.327649384872, 3656.5063716398477, 5147.562457191143, 5275.630705850592, 5293.708846013467, 5294.0, 5342.813001544927, 3671.467637192592, 3682.4476328550395, 3688.280785246851, 3690.2102480297035, 3697.149655579232, 3713.405855063177, 3722.4230244312175, 3725.8137093145233, 3737.7944213068, 3744.8876533704033, 4279.379489973936, 4283.593058659422, 4285.785710714452, 4293.034067334825, 4297.183535128378, 4943.355304911926, 5109.795608175631, 5113.386393632713, 5122.3096378195105, 5135.87160320995, 1266.835311409511, 1277.7384030266562, 1278.0797825565578, 1285.8971282297393, 1286.2218357893528, 817.5912043978011, 818.6848063495478, 849.6473963305159, 878.767126711422, 881.8456770065213, 4443.466783985942, 4446.377507149002, 4455.460387579114, 4464.6428285737065, 4489.595936365743, 5157.174852023733, 5185.22221666753, 5186.351706036746, 5193.870153246124, 5260.973695131576, 4324.978375108104, 4395.890102747457, 4462.3083422068985, 4509.053098849278, 4511.0, 2780.7775377969715, 2800.7899407544514, 2805.8877644893973, 2810.339570201001, 2814.9859250703616, 4889.559939605452, 4901.313816065754, 4908.263760435963, 4908.435529914105, 4910.76560165124, 5108.744562771846, 5285.577153827685, 5382.2464854920345, 5397.568194544427, 5432.483914028161, 4920.6801557898625, 4923.138450771173, 4935.777889994959, 4952.7771250294545, 4968.366765614231, 5299.33758280215, 5307.893842123213, 5308.495692909168, 5310.840674779763, 5312.468753124656, 4921.416256465384, 5204.386640141568, 5208.661437006583, 5218.0, 5227.163653815372, 4910.140725373117, 4930.112579735682, 4937.259411088222, 4941.950580494149, 4945.406551213878, 3711.0, 3711.6473934976134, 3717.628237176261, 3721.3673675475775, 3734.495843061152, 5122.974385128051, 5266.473352664703, 5278.392984806643, 5283.2075188722, 5290.338707661543, 5103.234514822658, 5126.359205099363, 5141.948580514297, 5142.922856157086, 5148.330717006766, 5097.898042039213, 5126.820561280338, 5139.563137133236, 5142.897142057063, 5159.355080614923, 4749.976250118727, 4834.274858771212, 5036.244563315532, 5040.949590504048, 5048.873778155576, 4976.552110310089, 5014.323066385991, 5022.799088036438, 5027.572656324253, 5032.6980381177245, 4864.318995340726, 5006.849794506171, 5048.823291184938, 5059.215821547666, 5061.22857000047], "value": 3823.4617766713386, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.1570918532942, 653.2585515439974, 664.5846346033729, 701.281186783547, 711.6655172069126, 11608.651740447778, 12016.218945768518, 12079.45642446091, 12096.153269271155, 13121.803172952414, 12856.22862628243, 12908.741825163515, 13004.869951300485, 13017.73964520709, 13038.0, 625.8748250349926, 764.0449438202247, 779.0962483519105, 791.1060501633175, 795.387551585279, 786.8347646994138, 803.0884945586772, 803.2650125135523, 803.6343463724021, 803.7709252862935, 840.1934143222484, 845.8815765792793, 846.5936350551739, 846.8391005708926, 847.5338563789891, 647.0359164844396, 791.6714563456159, 822.6421506644568, 829.1087081387533, 830.0371568980015, 612.01160126396, 612.4426771637833, 612.4610342898266, 612.6783438694677, 612.9172561704157, 12786.168899021533, 12817.935910320388, 12823.679408014781, 12832.615021549369, 12836.294003829786, 11496.252743571724, 11903.345316007617, 11918.404079795975, 11978.880211197864, 12320.265024895998, 11402.771944561146, 11545.826812597817, 11575.479103440366, 11623.76752464946, 11644.825327620092, 4102.917941641181, 4148.502179738421, 4149.522804877448, 4165.604267594604, 4171.874843754692, 57430.0, 57477.425225747626, 57543.0, 57563.71218143882, 57608.0, 8957.507337096393, 9348.439093654402, 9369.109934556207, 9940.751481213027, 10147.949260253652, 16134.435294764628, 16723.49829505117, 16736.581585460463, 17194.484165475056, 17207.0, 6949.93050069503, 6960.095187625576, 7106.0, 7125.572465652078, 7227.710891564278, 3730.5336832895887, 3761.9435708464393, 3892.6691231245095, 3912.139329347539, 3918.490596222473, 2863.3700585871075, 2978.6723460419335, 2982.7017298270434, 2991.4316279906748, 2993.3414648777234, 496.74417674897455, 506.1319836480454, 524.307913554105, 527.6174773289334, 527.860117068977, 582.0890306670047, 586.0338564117325, 588.2940471434296, 598.853280946171, 611.9082137679384, 7797.0, 8334.166583341617, 8358.832823343499, 8398.496090234605, 8463.619137138843, 595.1875689683551, 606.4693393280879, 610.4597431273355, 631.7220423013952, 635.8632893927828, 4075.3071977763257, 4108.36320370343, 4160.292750232467, 4219.748781905177, 4257.765822879772, 98161.509192455, 99768.0, 100241.0, 100684.49657751665, 103033.48483257685, 88922.0, 90149.0, 90595.54702226447, 92814.0, 93989.53005235067, 80068.0, 81419.5929020363, 83419.58290208632, 83741.58129209315, 84247.15752842516, 7748.418868584766, 7802.960985195038, 7954.920450795418, 8040.195980401913, 8162.2653961141405, 47246.0, 47447.288290676355, 47601.52398475971, 48669.5133048665, 49752.0, 63101.36898630955, 69526.65236673987, 69552.0, 71337.28662713307, 72473.63763181362, 10098.646547370807, 10108.0, 10246.487675616338, 10279.588816447558, 10285.9485702571, 10832.512536936014, 10837.187210959051, 11032.558697652325, 11381.146414019147, 11452.541898324307, 10380.221483388927, 10422.218333624856, 10487.632932847313, 10559.419231942316, 10966.451677416257, 10763.246572739834, 10990.230683852373, 11019.504122314675, 11198.496067676811, 11346.20576559666, 10603.522841471999, 10801.297915635458, 10846.566137354734, 10846.945765271123, 11149.108071354434, 8491.83016339682, 8702.216800487986, 8873.73378798637, 9176.862347064933, 9409.952950235205, 9115.772105697146, 9340.579673914826, 9376.578053987723, 9455.669051583161, 9479.810403792024], "value": 6535.052478515659, "unit": "score"}], "name": "dromaeo_css", "value": 6347.397860360704, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 112.0, 114.0, 113.0, 113.0, 111.0, 113.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 138.0, 205.0, 131.0, 155.0, 168.0, 131.0, 182.0, 135.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 113.0, 76.0, 77.0, 75.0, 75.0, 108.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 119.0, 85.0, 85.0, 85.0, 118.0, 85.0, 85.0, 134.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 67.0, 66.0, 64.0, 65.0, 66.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 83.0, 82.0, 82.0, 84.0, 84.0, 89.0, 115.0, 84.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 138.0, 131.0, 132.0, 127.0, 142.0, 133.0, 144.0, 132.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 168.0, 168.0, 173.0, 172.0, 168.0, 165.0, 173.0, 166.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 65.0, 66.0, 66.0, 69.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1550.7000000000003, "alertThreshold": 2.0}]} 13:15:08 INFO - Return code: 0 13:15:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:15:08 INFO - # TBPL SUCCESS # 13:15:08 INFO - Running post-action listener: _resource_record_post_action 13:15:08 INFO - ##### 13:15:08 INFO - ##### Finished run-tests step (success) 13:15:08 INFO - ##### 13:15:08 INFO - Running post-run listener: _resource_record_post_run 13:15:08 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534499328; Read time: 16; Write time: 562848 13:15:08 INFO - TinderboxPrint: CPU usage
13.1% 13:15:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:15:08 INFO - TinderboxPrint: I/O write bytes / time
534,499,328 / 562,848 13:15:08 INFO - TinderboxPrint: CPU idle
8,323.2 (86.9%) 13:15:08 INFO - TinderboxPrint: CPU user
1,211.8 (12.6%) 13:15:08 INFO - TinderboxPrint: Swap in / out
0 / 0 13:15:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 245334016; Read time: 0; Write time: 236780 13:15:08 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 289165312; Read time: 0; Write time: 326068 13:15:08 INFO - Running post-run listener: _upload_blobber_files 13:15:08 INFO - Blob upload gear active. 13:15:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:15:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:15:08 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:15:08 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:15:09 INFO - (blobuploader) - INFO - Open directory for files ... 13:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:10 INFO - (blobuploader) - INFO - Done attempting. 13:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:10 INFO - (blobuploader) - INFO - Done attempting. 13:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:15:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:14 INFO - (blobuploader) - INFO - Done attempting. 13:15:14 INFO - (blobuploader) - INFO - Iteration through files over. 13:15:14 INFO - Return code: 0 13:15:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:15:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:15:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/36ed6ce13572106b025fd249196681eaf9120b75a0a8116f616829afae0542fe02a85fc3471c466f7d44c6f1e15723d8fff77b2e96475e1283bd996edd3608a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/68badd08e95fcddf9e917531341d642166dd069220ac04a9337ec5f608f232561d652ab8f1b01819ee83d866932bbc4cdb2e19aa769c92484e20d0208168c71a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f522ffbb6c860593ef99058158ffb80b99bd070b1f207bd136de4815c7d460a5526ebf7681c9752960aa99ab3c15b94527a4f96f92ec656a93d2a1cbbeff807"} 13:15:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:15:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:15:14 INFO - Contents: 13:15:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/36ed6ce13572106b025fd249196681eaf9120b75a0a8116f616829afae0542fe02a85fc3471c466f7d44c6f1e15723d8fff77b2e96475e1283bd996edd3608a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/68badd08e95fcddf9e917531341d642166dd069220ac04a9337ec5f608f232561d652ab8f1b01819ee83d866932bbc4cdb2e19aa769c92484e20d0208168c71a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f522ffbb6c860593ef99058158ffb80b99bd070b1f207bd136de4815c7d460a5526ebf7681c9752960aa99ab3c15b94527a4f96f92ec656a93d2a1cbbeff807"} 13:15:14 INFO - Running post-run listener: copy_logs_to_upload_dir 13:15:14 INFO - Copying logs to upload dir... 13:15:14 INFO - mkdir: /builds/slave/test/build/upload/logs 13:15:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.300978 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-28 13:15:13.695726) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 13:15:13.699475) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/36ed6ce13572106b025fd249196681eaf9120b75a0a8116f616829afae0542fe02a85fc3471c466f7d44c6f1e15723d8fff77b2e96475e1283bd996edd3608a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/68badd08e95fcddf9e917531341d642166dd069220ac04a9337ec5f608f232561d652ab8f1b01819ee83d866932bbc4cdb2e19aa769c92484e20d0208168c71a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f522ffbb6c860593ef99058158ffb80b99bd070b1f207bd136de4815c7d460a5526ebf7681c9752960aa99ab3c15b94527a4f96f92ec656a93d2a1cbbeff807"} build_url:https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/XzrzLgMjS72vFAtZTBu8rA/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/Autoland-Non-PGO/sha512/36ed6ce13572106b025fd249196681eaf9120b75a0a8116f616829afae0542fe02a85fc3471c466f7d44c6f1e15723d8fff77b2e96475e1283bd996edd3608a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/68badd08e95fcddf9e917531341d642166dd069220ac04a9337ec5f608f232561d652ab8f1b01819ee83d866932bbc4cdb2e19aa769c92484e20d0208168c71a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f522ffbb6c860593ef99058158ffb80b99bd070b1f207bd136de4815c7d460a5526ebf7681c9752960aa99ab3c15b94527a4f96f92ec656a93d2a1cbbeff807"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 13:15:13.729259) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 13:15:13.729989) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467143487.942620-1978133339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 13:15:13.812994) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 13:15:13.813394) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 13:15:13.813753) ========= ========= Total master_lag: 0.19 =========