builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1467143658.02 results: success (0) buildid: 20160628113822 builduid: 2a860460dfac4910bd597f7937487a03 revision: 5b3be977f2a28eaeed03b68c87bd1e7fa898ed25 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:18.017171) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:18.017576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:18.017846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:18.065843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:18.066138) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 12:54:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2016-06-28 12:54:18 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.213831 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:18.299499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:18.299810) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.093990 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:18.403598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:18.403971) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 12:54:18,578 truncating revision to first 12 chars 2016-06-28 12:54:18,578 Setting DEBUG logging. 2016-06-28 12:54:18,578 attempt 1/10 2016-06-28 12:54:18,578 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:18,884 unpacking tar archive at: autoland-5b3be977f2a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641026 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:19.058340) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:19.058609) ========= script_repo_revision: 5b3be977f2a28eaeed03b68c87bd1e7fa898ed25 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:19.058975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:19.059292) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 12:54:19.071855) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-06-28 12:54:19.072112) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:54:19 INFO - MultiFileLogger online at 20160628 12:54:19 in /builds/slave/test 12:54:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:19 INFO - {'append_to_log': False, 12:54:19 INFO - 'base_work_dir': '/builds/slave/test', 12:54:19 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:54:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:19 INFO - 'branch': 'Autoland-Non-PGO', 12:54:19 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:19 INFO - 'config_files': ('talos/linux_config.py',), 12:54:19 INFO - 'default_actions': ('clobber', 12:54:19 INFO - 'read-buildbot-config', 12:54:19 INFO - 'download-and-extract', 12:54:19 INFO - 'populate-webroot', 12:54:19 INFO - 'create-virtualenv', 12:54:19 INFO - 'install', 12:54:19 INFO - 'run-tests'), 12:54:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:19 INFO - 'download_minidump_stackwalk': True, 12:54:19 INFO - 'download_symbols': 'ondemand', 12:54:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:19 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:19 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:19 INFO - 'installer_path': 'installer.exe', 12:54:19 INFO - 'log_level': 'info', 12:54:19 INFO - 'log_name': 'talos', 12:54:19 INFO - 'log_to_console': True, 12:54:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:54:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:54:19 INFO - 'opt_config_files': (), 12:54:19 INFO - 'pip_index': False, 12:54:19 INFO - 'sps_profile': False, 12:54:19 INFO - 'sps_profile_interval': 0, 12:54:19 INFO - 'suite': 'dromaeojs-e10s', 12:54:19 INFO - 'system_bits': '32', 12:54:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:19 INFO - 'title': 'talos-linux64-ix-004', 12:54:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:19 INFO - 'use_talos_json': True, 12:54:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:19 INFO - 'work_dir': 'build'} 12:54:19 INFO - ##### 12:54:19 INFO - ##### Running clobber step. 12:54:19 INFO - ##### 12:54:19 INFO - Running pre-action listener: _resource_record_pre_action 12:54:19 INFO - Running main action method: clobber 12:54:19 INFO - rmtree: /builds/slave/test/build 12:54:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:21 INFO - Running post-action listener: _resource_record_post_action 12:54:21 INFO - ##### 12:54:21 INFO - ##### Finished clobber step (success) 12:54:21 INFO - ##### 12:54:21 INFO - ##### 12:54:21 INFO - ##### Running read-buildbot-config step. 12:54:21 INFO - ##### 12:54:21 INFO - Running pre-action listener: _resource_record_pre_action 12:54:21 INFO - Running main action method: read_buildbot_config 12:54:21 INFO - Using buildbot properties: 12:54:21 INFO - { 12:54:21 INFO - "project": "", 12:54:21 INFO - "product": "firefox", 12:54:21 INFO - "script_repo_revision": "production", 12:54:21 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 12:54:21 INFO - "repository": "", 12:54:21 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 12:54:21 INFO - "buildid": "20160628113822", 12:54:21 INFO - "pgo_build": "False", 12:54:21 INFO - "basedir": "/builds/slave/test", 12:54:21 INFO - "buildnumber": 7, 12:54:21 INFO - "slavename": "talos-linux64-ix-004", 12:54:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:54:21 INFO - "platform": "ubuntu64_hw", 12:54:21 INFO - "scheduler": "tests-autoland-linux64-talos", 12:54:21 INFO - "branch": "autoland", 12:54:21 INFO - "repo_path": "integration/autoland", 12:54:21 INFO - "revision": "5b3be977f2a28eaeed03b68c87bd1e7fa898ed25", 12:54:21 INFO - "stage_platform": "linux64", 12:54:21 INFO - "builduid": "2a860460dfac4910bd597f7937487a03", 12:54:21 INFO - "slavebuilddir": "test" 12:54:21 INFO - } 12:54:21 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:21 INFO - Running post-action listener: _resource_record_post_action 12:54:21 INFO - ##### 12:54:21 INFO - ##### Finished read-buildbot-config step (success) 12:54:21 INFO - ##### 12:54:21 INFO - ##### 12:54:21 INFO - ##### Running download-and-extract step. 12:54:21 INFO - ##### 12:54:21 INFO - Running pre-action listener: _resource_record_pre_action 12:54:21 INFO - Running main action method: download_and_extract 12:54:21 INFO - mkdir: /builds/slave/test/build/tests 12:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:21 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:21 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:21 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:21 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:21 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:22 INFO - Downloaded 1361 bytes. 12:54:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:54:22 INFO - Using the following test package requirements: 12:54:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:54:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:54:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'jsshell-linux-x86_64.zip'], 12:54:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:54:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:54:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:54:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:54:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:54:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:54:22 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:22 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:22 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:22 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:22 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:22 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:37 INFO - Downloaded 22700063 bytes. 12:54:37 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:37 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:38 INFO - Return code: 0 12:54:38 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: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.common.tests.zip 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:54:38 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:44 INFO - Downloaded 22700063 bytes. 12:54:44 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:44 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:46 INFO - Return code: 0 12:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:46 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:46 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:46 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:46 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:46 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:52 INFO - Downloaded 14405245 bytes. 12:54:52 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:52 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:52 INFO - Return code: 0 12:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:52 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:52 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:52 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:52 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:52 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:56 INFO - Downloaded 56438805 bytes. 12:54:56 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:56 INFO - mkdir: /builds/slave/test/properties 12:54:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:56 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:56 INFO - Contents: 12:54:56 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:57 INFO - Running post-action listener: _resource_record_post_action 12:54:57 INFO - Running post-action listener: set_extra_try_arguments 12:54:57 INFO - ##### 12:54:57 INFO - ##### Finished download-and-extract step (success) 12:54:57 INFO - ##### 12:54:57 INFO - ##### 12:54:57 INFO - ##### Running populate-webroot step. 12:54:57 INFO - ##### 12:54:57 INFO - Running pre-action listener: _resource_record_pre_action 12:54:57 INFO - Running main action method: populate_webroot 12:54:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:57 INFO - '--tppagecycles', 12:54:57 INFO - '7'], 12:54:57 INFO - 'tests': ['tsvgm']}}, 12:54:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['damp', 'tps']}, 12:54:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'tests': ['damp', 'tps']}, 12:54:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['dromaeo_dom']}, 12:54:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['basic_compositor_video']}, 12:54:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:54:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['tsvgx', 12:54:57 INFO - 'tsvgr_opacity', 12:54:57 INFO - 'tart', 12:54:57 INFO - 'tscrollx', 12:54:57 INFO - 'cart']}, 12:54:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:57 INFO - 'tsvgr_opacity', 12:54:57 INFO - 'tart', 12:54:57 INFO - 'tscrollx', 12:54:57 INFO - 'cart']}, 12:54:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['tp5o']}, 12:54:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'tests': ['tp5o']}, 12:54:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'talos_options': ['--disable-e10s', 12:54:57 INFO - '--xperf_path', 12:54:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:57 INFO - 'tests': ['tp5n']}, 12:54:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'talos_options': ['--xperf_path', 12:54:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:57 INFO - 'tests': ['tp5n']}}, 12:54:57 INFO - 'talos.zip': {'path': '', 12:54:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:57 INFO - Running post-action listener: _resource_record_post_action 12:54:57 INFO - ##### 12:54:57 INFO - ##### Finished populate-webroot step (success) 12:54:57 INFO - ##### 12:54:57 INFO - ##### 12:54:57 INFO - ##### Running create-virtualenv step. 12:54:57 INFO - ##### 12:54:57 INFO - Running pre-action listener: _resource_record_pre_action 12:54:57 INFO - Running main action method: create_virtualenv 12:54:57 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:57 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:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:57 INFO - Using real prefix '/usr' 12:54:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:58 INFO - Installing distribute.............................................................................................................................................................................................done. 12:55:00 INFO - Installing pip.................done. 12:55:00 INFO - Return code: 0 12:55:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2578400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607570>, '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 0x2608470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2608900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', '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:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:55:00 INFO - Using env: {'DISPLAY': ':0', 12:55:00 INFO - 'HOME': '/home/cltbld', 12:55:00 INFO - 'LANG': 'en_US.UTF-8', 12:55:00 INFO - 'LANGUAGE': 'en_US:en', 12:55:00 INFO - 'LOGNAME': 'cltbld', 12:55:00 INFO - 'MAIL': '/var/mail/cltbld', 12:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:00 INFO - 'MOZ_NO_REMOTE': '1', 12:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:00 INFO - 'NO_EM_RESTART': '1', 12:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:00 INFO - 'PWD': '/builds/slave/test', 12:55:00 INFO - 'SHELL': '/bin/bash', 12:55:00 INFO - 'SHLVL': '1', 12:55:00 INFO - 'TERM': 'linux', 12:55:00 INFO - 'TMOUT': '86400', 12:55:00 INFO - 'USER': 'cltbld', 12:55:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', 12:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:00 INFO - '_': '/tools/buildbot/bin/python'} 12:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:00 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:55:00 INFO - Cleaning up... 12:55:00 INFO - Return code: 0 12:55:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2349030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2578400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607570>, '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 0x2608470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2608900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', '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:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:55:00 INFO - Using env: {'DISPLAY': ':0', 12:55:00 INFO - 'HOME': '/home/cltbld', 12:55:00 INFO - 'LANG': 'en_US.UTF-8', 12:55:00 INFO - 'LANGUAGE': 'en_US:en', 12:55:00 INFO - 'LOGNAME': 'cltbld', 12:55:00 INFO - 'MAIL': '/var/mail/cltbld', 12:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:00 INFO - 'MOZ_NO_REMOTE': '1', 12:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:00 INFO - 'NO_EM_RESTART': '1', 12:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:00 INFO - 'PWD': '/builds/slave/test', 12:55:00 INFO - 'SHELL': '/bin/bash', 12:55:00 INFO - 'SHLVL': '1', 12:55:00 INFO - 'TERM': 'linux', 12:55:00 INFO - 'TMOUT': '86400', 12:55:00 INFO - 'USER': 'cltbld', 12:55:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', 12:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:00 INFO - '_': '/tools/buildbot/bin/python'} 12:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:00 INFO - Downloading/unpacking psutil>=3.1.1 12:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:55:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:55:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:55:02 INFO - Installing collected packages: psutil 12:55:02 INFO - Running setup.py install for psutil 12:55:02 INFO - building 'psutil._psutil_linux' extension 12:55:02 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:55:04 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:55:04 INFO - building 'psutil._psutil_posix' extension 12:55:04 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:55:04 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:55:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:55:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:55:04 INFO - Successfully installed psutil 12:55:04 INFO - Cleaning up... 12:55:04 INFO - Return code: 0 12:55:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:04 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 0x2349030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2578400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607570>, '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 0x2608470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2608900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', '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:04 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:55:04 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:55:04 INFO - Using env: {'DISPLAY': ':0', 12:55:04 INFO - 'HOME': '/home/cltbld', 12:55:04 INFO - 'LANG': 'en_US.UTF-8', 12:55:04 INFO - 'LANGUAGE': 'en_US:en', 12:55:04 INFO - 'LOGNAME': 'cltbld', 12:55:04 INFO - 'MAIL': '/var/mail/cltbld', 12:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:04 INFO - 'MOZ_NO_REMOTE': '1', 12:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:04 INFO - 'NO_EM_RESTART': '1', 12:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:04 INFO - 'PWD': '/builds/slave/test', 12:55:04 INFO - 'SHELL': '/bin/bash', 12:55:04 INFO - 'SHLVL': '1', 12:55:04 INFO - 'TERM': 'linux', 12:55:04 INFO - 'TMOUT': '86400', 12:55:04 INFO - 'USER': 'cltbld', 12:55:04 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', 12:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:04 INFO - '_': '/tools/buildbot/bin/python'} 12:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:55:05 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:05 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:05 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:05 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:05 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:05 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 mozsystemmonitor-0.3.tar.gz 12:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:55:06 INFO - Installing collected packages: mozsystemmonitor 12:55:06 INFO - Running setup.py install for mozsystemmonitor 12:55:07 INFO - Successfully installed mozsystemmonitor 12:55:07 INFO - Cleaning up... 12:55:07 INFO - Return code: 0 12:55:07 INFO - Installing jsonschema==2.5.1 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2578400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607570>, '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 0x2608470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2608900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', '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==2.5.1'] 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==2.5.1 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': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', 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 - Downloading/unpacking jsonschema==2.5.1 12:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:55:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:55:09 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:09 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:09 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:09 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:09 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:09 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:09 INFO - Downloading functools32-3.2.3-2.tar.gz 12:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:55:09 INFO - warning: no files found matching '*.txt' 12:55:09 INFO - no previously-included directories found matching 'build' 12:55:09 INFO - no previously-included directories found matching 'dist' 12:55:09 INFO - no previously-included directories found matching '.git*' 12:55:09 INFO - Installing collected packages: jsonschema, functools32 12:55:09 INFO - Running setup.py install for functools32 12:55:09 INFO - warning: no files found matching '*.txt' 12:55:09 INFO - no previously-included directories found matching 'build' 12:55:09 INFO - no previously-included directories found matching 'dist' 12:55:09 INFO - no previously-included directories found matching '.git*' 12:55:09 INFO - Successfully installed jsonschema functools32 12:55:09 INFO - Cleaning up... 12:55:09 INFO - Return code: 0 12:55:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2349030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2578400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607570>, '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 0x2608470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2608900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', '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:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:55:09 INFO - Using env: {'DISPLAY': ':0', 12:55:09 INFO - 'HOME': '/home/cltbld', 12:55:09 INFO - 'LANG': 'en_US.UTF-8', 12:55:09 INFO - 'LANGUAGE': 'en_US:en', 12:55:09 INFO - 'LOGNAME': 'cltbld', 12:55:09 INFO - 'MAIL': '/var/mail/cltbld', 12:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:09 INFO - 'MOZ_NO_REMOTE': '1', 12:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:09 INFO - 'NO_EM_RESTART': '1', 12:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:09 INFO - 'PWD': '/builds/slave/test', 12:55:09 INFO - 'SHELL': '/bin/bash', 12:55:09 INFO - 'SHLVL': '1', 12:55:09 INFO - 'TERM': 'linux', 12:55:09 INFO - 'TMOUT': '86400', 12:55:09 INFO - 'USER': 'cltbld', 12:55:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', 12:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:09 INFO - '_': '/tools/buildbot/bin/python'} 12:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:09 INFO - Downloading/unpacking blobuploader==1.2.4 12:55:09 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:09 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:09 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:09 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:09 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:09 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:11 INFO - Downloading blobuploader-1.2.4.tar.gz 12:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:55:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:55:11 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:11 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:11 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:11 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:11 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:11 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:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:55:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:55:12 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:12 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:12 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:12 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:12 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:12 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:12 INFO - Downloading docopt-0.6.1.tar.gz 12:55:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:55:12 INFO - Installing collected packages: blobuploader, requests, docopt 12:55:12 INFO - Running setup.py install for blobuploader 12:55:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:55:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:55:12 INFO - Running setup.py install for requests 12:55:12 INFO - Running setup.py install for docopt 12:55:13 INFO - Successfully installed blobuploader requests docopt 12:55:13 INFO - Cleaning up... 12:55:13 INFO - Return code: 0 12:55:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:13 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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:13 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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:13 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 0x2349030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2578400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607570>, '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 0x2608470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2608900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', '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:13 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:55:13 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:55:13 INFO - Using env: {'DISPLAY': ':0', 12:55:13 INFO - 'HOME': '/home/cltbld', 12:55:13 INFO - 'LANG': 'en_US.UTF-8', 12:55:13 INFO - 'LANGUAGE': 'en_US:en', 12:55:13 INFO - 'LOGNAME': 'cltbld', 12:55:13 INFO - 'MAIL': '/var/mail/cltbld', 12:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:13 INFO - 'MOZ_NO_REMOTE': '1', 12:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:13 INFO - 'NO_EM_RESTART': '1', 12:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:13 INFO - 'PWD': '/builds/slave/test', 12:55:13 INFO - 'SHELL': '/bin/bash', 12:55:13 INFO - 'SHLVL': '1', 12:55:13 INFO - 'TERM': 'linux', 12:55:13 INFO - 'TMOUT': '86400', 12:55:13 INFO - 'USER': 'cltbld', 12:55:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', 12:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:13 INFO - '_': '/tools/buildbot/bin/python'} 12:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:55:13 INFO - Running setup.py (path:/tmp/pip-vy3ElN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:55:13 INFO - Running setup.py (path:/tmp/pip-24O7do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:55:13 INFO - Running setup.py (path:/tmp/pip-8P6krZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:55:13 INFO - Running setup.py (path:/tmp/pip-8upRqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:55:13 INFO - Running setup.py (path:/tmp/pip-VA7UfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:55:13 INFO - Running setup.py (path:/tmp/pip-hbhG9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:55:13 INFO - Running setup.py (path:/tmp/pip-stveXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:13 INFO - Running setup.py (path:/tmp/pip-8C4INP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:13 INFO - Running setup.py (path:/tmp/pip-NOfmXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:13 INFO - Running setup.py (path:/tmp/pip-a_Ru5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:14 INFO - Running setup.py (path:/tmp/pip-qQSS0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:14 INFO - Running setup.py (path:/tmp/pip-pUr5_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:14 INFO - Running setup.py (path:/tmp/pip-dPk0hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:14 INFO - Running setup.py (path:/tmp/pip-LbAaw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:14 INFO - Running setup.py (path:/tmp/pip-JEDxL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:14 INFO - Running setup.py (path:/tmp/pip-jbKj7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:14 INFO - Running setup.py (path:/tmp/pip-BBPMJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:55:14 INFO - Running setup.py install for manifestparser 12:55:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:55:14 INFO - Running setup.py install for mozcrash 12:55:14 INFO - Running setup.py install for mozdebug 12:55:14 INFO - Running setup.py install for mozdevice 12:55:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:55:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:55:14 INFO - Running setup.py install for mozfile 12:55:15 INFO - Running setup.py install for mozhttpd 12:55:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Running setup.py install for mozinfo 12:55:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Running setup.py install for mozInstall 12:55:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Running setup.py install for mozleak 12:55:15 INFO - Running setup.py install for mozlog 12:55:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Running setup.py install for moznetwork 12:55:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Running setup.py install for mozprocess 12:55:15 INFO - Running setup.py install for mozprofile 12:55:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:55:15 INFO - Running setup.py install for mozrunner 12:55:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:55:16 INFO - Running setup.py install for mozscreenshot 12:55:16 INFO - Running setup.py install for moztest 12:55:16 INFO - Running setup.py install for mozversion 12:55:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:55:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:55:16 INFO - Cleaning up... 12:55:16 INFO - Return code: 0 12:55:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:16 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 0x2349030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2578400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607570>, '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 0x2608470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2608900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', '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:16 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:16 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:16 INFO - Using env: {'DISPLAY': ':0', 12:55:16 INFO - 'HOME': '/home/cltbld', 12:55:16 INFO - 'LANG': 'en_US.UTF-8', 12:55:16 INFO - 'LANGUAGE': 'en_US:en', 12:55:16 INFO - 'LOGNAME': 'cltbld', 12:55:16 INFO - 'MAIL': '/var/mail/cltbld', 12:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:16 INFO - 'MOZ_NO_REMOTE': '1', 12:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:16 INFO - 'NO_EM_RESTART': '1', 12:55:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:16 INFO - 'PWD': '/builds/slave/test', 12:55:16 INFO - 'SHELL': '/bin/bash', 12:55:16 INFO - 'SHLVL': '1', 12:55:16 INFO - 'TERM': 'linux', 12:55:16 INFO - 'TMOUT': '86400', 12:55:16 INFO - 'USER': 'cltbld', 12:55:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', 12:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:16 INFO - '_': '/tools/buildbot/bin/python'} 12:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:55:16 INFO - Running setup.py (path:/tmp/pip-PwEVB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:55:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:55:16 INFO - Running setup.py (path:/tmp/pip-ubBMHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:55:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:55:16 INFO - Running setup.py (path:/tmp/pip-SVTqvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:55:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:55:16 INFO - Running setup.py (path:/tmp/pip-qDNudc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:55:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:55:16 INFO - Running setup.py (path:/tmp/pip-HdVKAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:55:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:55:16 INFO - Running setup.py (path:/tmp/pip-EQI2kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:55:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:55:16 INFO - Running setup.py (path:/tmp/pip-x6yopV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:17 INFO - Running setup.py (path:/tmp/pip-81fgpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:17 INFO - Running setup.py (path:/tmp/pip-e7w8nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:17 INFO - Running setup.py (path:/tmp/pip-vFZo4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:17 INFO - Running setup.py (path:/tmp/pip-mglmSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:17 INFO - Running setup.py (path:/tmp/pip-J1jmbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:17 INFO - Running setup.py (path:/tmp/pip-GmD_VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:17 INFO - Running setup.py (path:/tmp/pip-6Jw3le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:17 INFO - Running setup.py (path:/tmp/pip-1kwnkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:17 INFO - Running setup.py (path:/tmp/pip-UpuEup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:17 INFO - Running setup.py (path:/tmp/pip-qPQNgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:17 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:17 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:17 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:17 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:17 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:17 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:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:55:17 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:17 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:17 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:17 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:17 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:17 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:19 INFO - Downloading blessings-1.6.tar.gz 12:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:55:19 INFO - Installing collected packages: blessings 12:55:19 INFO - Running setup.py install for blessings 12:55:19 INFO - Successfully installed blessings 12:55:19 INFO - Cleaning up... 12:55:19 INFO - Return code: 0 12:55:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:55:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:20 INFO - Reading from file tmpfile_stdout 12:55:20 INFO - Current package versions: 12:55:20 INFO - argparse == 1.2.1 12:55:20 INFO - blessings == 1.6 12:55:20 INFO - blobuploader == 1.2.4 12:55:20 INFO - docopt == 0.6.1 12:55:20 INFO - functools32 == 3.2.3-2 12:55:20 INFO - jsonschema == 2.5.1 12:55:20 INFO - manifestparser == 1.1 12:55:20 INFO - mozInstall == 1.12 12:55:20 INFO - mozcrash == 0.17 12:55:20 INFO - mozdebug == 0.1 12:55:20 INFO - mozdevice == 0.48 12:55:20 INFO - mozfile == 1.2 12:55:20 INFO - mozhttpd == 0.7 12:55:20 INFO - mozinfo == 0.9 12:55:20 INFO - mozleak == 0.1 12:55:20 INFO - mozlog == 3.2 12:55:20 INFO - moznetwork == 0.27 12:55:20 INFO - mozprocess == 0.22 12:55:20 INFO - mozprofile == 0.28 12:55:20 INFO - mozrunner == 6.11 12:55:20 INFO - mozscreenshot == 0.1 12:55:20 INFO - mozsystemmonitor == 0.3 12:55:20 INFO - moztest == 0.7 12:55:20 INFO - mozversion == 1.4 12:55:20 INFO - psutil == 3.1.1 12:55:20 INFO - requests == 1.2.3 12:55:20 INFO - wsgiref == 0.1.2 12:55:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:20 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 0x2349030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2578400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607570>, '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 0x2608470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2608900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 12:55:20 INFO - 'HOME': '/home/cltbld', 12:55:20 INFO - 'LANG': 'en_US.UTF-8', 12:55:20 INFO - 'LANGUAGE': 'en_US:en', 12:55:20 INFO - 'LOGNAME': 'cltbld', 12:55:20 INFO - 'MAIL': '/var/mail/cltbld', 12:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:20 INFO - 'MOZ_NO_REMOTE': '1', 12:55:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:20 INFO - 'NO_EM_RESTART': '1', 12:55:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:20 INFO - 'PWD': '/builds/slave/test', 12:55:20 INFO - 'SHELL': '/bin/bash', 12:55:20 INFO - 'SHLVL': '1', 12:55:20 INFO - 'TERM': 'linux', 12:55:20 INFO - 'TMOUT': '86400', 12:55:20 INFO - 'USER': 'cltbld', 12:55:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', 12:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:20 INFO - '_': '/tools/buildbot/bin/python'} 12:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 INFO - Cleaning up... 12:55:20 INFO - Return code: 0 12:55:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:55:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:20 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 0x2349030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2578400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607570>, '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 0x2608470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2608900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 12:55:20 INFO - 'HOME': '/home/cltbld', 12:55:20 INFO - 'LANG': 'en_US.UTF-8', 12:55:20 INFO - 'LANGUAGE': 'en_US:en', 12:55:20 INFO - 'LOGNAME': 'cltbld', 12:55:20 INFO - 'MAIL': '/var/mail/cltbld', 12:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:20 INFO - 'MOZ_NO_REMOTE': '1', 12:55:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:20 INFO - 'NO_EM_RESTART': '1', 12:55:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:20 INFO - 'PWD': '/builds/slave/test', 12:55:20 INFO - 'SHELL': '/bin/bash', 12:55:20 INFO - 'SHLVL': '1', 12:55:20 INFO - 'TERM': 'linux', 12:55:20 INFO - 'TMOUT': '86400', 12:55:20 INFO - 'USER': 'cltbld', 12:55:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', 12:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:20 INFO - '_': '/tools/buildbot/bin/python'} 12:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:55:20 INFO - Cleaning up... 12:55:20 INFO - Return code: 0 12:55:20 INFO - Running post-action listener: _resource_record_post_action 12:55:20 INFO - Running post-action listener: _start_resource_monitoring 12:55:20 INFO - Starting resource monitoring. 12:55:20 INFO - ##### 12:55:20 INFO - ##### Finished create-virtualenv step (success) 12:55:20 INFO - ##### 12:55:20 INFO - ##### 12:55:20 INFO - ##### Running install step. 12:55:20 INFO - ##### 12:55:20 INFO - Running pre-action listener: _resource_record_pre_action 12:55:20 INFO - Running main action method: install 12:55:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:20 INFO - Reading from file tmpfile_stdout 12:55:20 INFO - Detecting whether we're running mozinstall >=1.0... 12:55:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:55:20 INFO - Reading from file tmpfile_stdout 12:55:20 INFO - Output received: 12:55:20 INFO - Usage: mozinstall [options] installer 12:55:20 INFO - Options: 12:55:20 INFO - -h, --help show this help message and exit 12:55:20 INFO - -d DEST, --destination=DEST 12:55:20 INFO - Directory to install application into. [default: 12:55:20 INFO - "/builds/slave/test"] 12:55:20 INFO - --app=APP Application being installed. [default: firefox] 12:55:20 INFO - mkdir: /builds/slave/test/build/application 12:55:20 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:20 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:37 INFO - Reading from file tmpfile_stdout 12:55:37 INFO - Output received: 12:55:37 INFO - /builds/slave/test/build/application/firefox/firefox 12:55:37 INFO - Running post-action listener: _resource_record_post_action 12:55:37 INFO - ##### 12:55:37 INFO - ##### Finished install step (success) 12:55:37 INFO - ##### 12:55:37 INFO - ##### 12:55:37 INFO - ##### Running run-tests step. 12:55:37 INFO - ##### 12:55:37 INFO - Running pre-action listener: _resource_record_pre_action 12:55:37 INFO - Running main action method: run_tests 12:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:55:37 INFO - Python 2.7.3 12:55:37 INFO - Return code: 0 12:55:37 INFO - grabbing minidump binary from tooltool 12:55: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:55:37 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 0x2607570>, '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 0x2608470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2608900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:55:37 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:37 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:37 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:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:55:37 INFO - Return code: 0 12:55:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:55:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:55:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:55:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:55:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:55:37 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-e10s', '--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-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:55:37 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-e10s --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-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:55:37 INFO - Using env: {'DISPLAY': ':0', 12:55:37 INFO - 'HOME': '/home/cltbld', 12:55:37 INFO - 'LANG': 'en_US.UTF-8', 12:55:37 INFO - 'LANGUAGE': 'en_US:en', 12:55:37 INFO - 'LOGNAME': 'cltbld', 12:55:37 INFO - 'MAIL': '/var/mail/cltbld', 12:55:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:55:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:37 INFO - 'MOZ_NO_REMOTE': '1', 12:55:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:55:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:37 INFO - 'NO_EM_RESTART': '1', 12:55:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:37 INFO - 'PWD': '/builds/slave/test', 12:55:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:55:37 INFO - 'SHELL': '/bin/bash', 12:55:37 INFO - 'SHLVL': '1', 12:55:37 INFO - 'TERM': 'linux', 12:55:37 INFO - 'TMOUT': '86400', 12:55:37 INFO - 'USER': 'cltbld', 12:55:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673', 12:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:37 INFO - '_': '/tools/buildbot/bin/python'} 12:55:37 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-e10s', '--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-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:55:37 INFO - mozversion application_buildid: 20160628113822 12:55:37 INFO - mozversion application_changeset: 5b3be977f2a28eaeed03b68c87bd1e7fa898ed25 12:55:37 INFO - mozversion application_display_name: Nightly 12:55:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:55:37 INFO - mozversion application_name: Firefox 12:55:37 INFO - mozversion application_remotingname: firefox 12:55:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:55:37 INFO - mozversion application_vendor: Mozilla 12:55:37 INFO - mozversion application_version: 50.0a1 12:55:37 INFO - mozversion platform_buildid: 20160628113822 12:55:37 INFO - mozversion platform_changeset: 5b3be977f2a28eaeed03b68c87bd1e7fa898ed25 12:55:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:55:37 INFO - mozversion platform_version: 50.0a1 12:55:37 INFO - using testdate: 1467143737 12:55:37 INFO - actual date: 1467143737 12:55:37 INFO - starting webserver on 'localhost:60294' 12:55:37 INFO - SUITE-START | Running 2 tests 12:55:37 INFO - TEST-START | dromaeo_css 12:55:37 INFO - operating with platform_type : linux_ 12:55:37 INFO - Initialising browser for dromaeo_css test... 12:55:37 INFO - TEST-INFO | started process 3304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6gGOHo/profile http://localhost:60294/getInfo.html) 12:55:45 INFO - PROCESS | 3304 | __metrics Screen width/height:1600/1200 12:55:45 INFO - PROCESS | 3304 | colorDepth:24 12:55:45 INFO - PROCESS | 3304 | Browser inner width/height: 1024/697 12:55:45 INFO - PROCESS | 3304 | __metrics 12:55:46 ERROR - PROCESS | 3304 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 12:55:47 INFO - TEST-INFO | 3304: exit 0 12:55:47 INFO - Browser initialized. 12:55:47 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:47 INFO - TEST-INFO | started process 3425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6gGOHo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:59 INFO - PROCESS | 3425 | RSS: Main: 169246720 12:55:59 INFO - PROCESS | 3425 | 12:56:48 INFO - PROCESS | 3425 | 1467143808835 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:59:01 INFO - PROCESS | 3425 | Cycle 1(1): loaded http://localhost:60294/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60294/tests/dromaeo/cssquery-ext.html) 12:59:02 INFO - PROCESS | 3425 | RSS: Main: 171712512 12:59:02 INFO - PROCESS | 3425 | 13:02:04 INFO - PROCESS | 3425 | Cycle 1(1): loaded http://localhost:60294/tests/dromaeo/cssquery-ext.html (next: http://localhost:60294/tests/dromaeo/cssquery-jquery.html) 13:02:05 INFO - PROCESS | 3425 | RSS: Main: 171364352 13:02:05 INFO - PROCESS | 3425 | 13:05:06 INFO - PROCESS | 3425 | Cycle 1(1): loaded http://localhost:60294/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60294/tests/dromaeo/cssquery-mootools.html) 13:05:07 INFO - PROCESS | 3425 | RSS: Main: 171982848 13:05:07 INFO - PROCESS | 3425 | 13:08:09 INFO - PROCESS | 3425 | Cycle 1(1): loaded http://localhost:60294/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60294/tests/dromaeo/cssquery-prototype.html) 13:08:10 INFO - PROCESS | 3425 | RSS: Main: 170020864 13:08:10 INFO - PROCESS | 3425 | 13:11:12 INFO - PROCESS | 3425 | Cycle 1(1): loaded http://localhost:60294/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60294/tests/dromaeo/cssquery-yui.html) 13:11:13 INFO - PROCESS | 3425 | RSS: Main: 171876352 13:11:13 INFO - PROCESS | 3425 | 13:14:15 INFO - PROCESS | 3425 | Cycle 1(1): loaded http://localhost:60294/tests/dromaeo/cssquery-yui.html (next: http://localhost:60294/tests/dromaeo/cssquery-dojo.html) 13:14:16 INFO - PROCESS | 3425 | RSS: Main: 172892160 13:14:16 INFO - PROCESS | 3425 | 13:14:16 INFO - PROCESS | 3425 | __start_tp_report 13:14:16 INFO - PROCESS | 3425 | _x_x_mozilla_page_load 13:14:16 INFO - PROCESS | 3425 | _x_x_mozilla_page_load_details 13:14:16 INFO - PROCESS | 3425 | |i|pagename|runs| 13:14:16 INFO - PROCESS | 3425 | |0;dojo.html;2625.816192866499;2667.6265322854792;2674;2674.4249986252953;2676.772474339681;4772.427308722949;4788.616910647144;4835.226363781791;4859.514048595139;4928.211486162215;4712.5758681718635;4752.168370535152;4771.785269662865;4806.9519304806945;4830.396200474941;4388.714733542325;4419.712718673276;4470.687051906351;4479.372887795711;4542.15970045541;4498.617617502517;4535.092981403716;4535.297028960516;4575.725456472605;4620.5610467005745;4428.512863585003;4457.64338852891;4561.657875659323;4568.2462393705;4593.908121837561;4450.977745111254;4458.777061146962;4469.620082293009;4482.910341793178;4495.1009798040195;4430.800613972347;4430.911381772379;4435;4445.066536027438;4483.21543729846;4733.905321893543;4814.590759785422;4820.517948205152;4859.149648811479;4869.099216644897;5157.767900444489;5169.767360468788;5181.326427564392;5188.766505507224;5235.188545775411;5254.763535640867;5265.447128051576;5267.236250743621;5267.710275934822;5309.787608495655;4853.0779151961015;4889.633277504201;4909.87725306863;4911.091448082152;4918.114739346916;5327.680339179584;5367.141257398797;5376.91934620981;5377.24718539397;5381;5156.20078887773;5161.66449180802;5170.069387510209;5175;5221.060209162311;5076.238564215398;5154.639175257696;5184.7407629618365;5192.584593232608;5199.818006369759;5126.282320475137;5171.043356978971;5171.095058364771;5177.094008548489;5195.558377537876;5059.519345662156;5162.380514338303;5174.120399532088;5175.094358487325;5180.352455943007;4254.446921900133;4393.6704747144095;4412.426384569985;4426.070525189746;4452.198604251201;3800.9809950950066;3821.0256384621744;3833.1758671885677;3851.672607828366;3857.4406711027304;4481.663875209372;4517.344984977226;4527.569880861313;4530.569595888385;4559.475660299108;5092.9745351273;5112.463191364927;5116.258142569381;5187.429382767892;5285.101532739443;4441.089576636782;4460.264056430718;4473.664475164375;4484.708493947883;4512.616427603625;4660.813567457264;4696.483386827446;4712.269598212282;4716.622670186377;4740.312654665055;4832.1543729847135;4845.103655823684;4847.61219102478;4862.708237505761;4891.902161956741;5073.898522029465;5079.517445842639;5106.821261255838;5114.15616423286;5147.510986456281;4715.952840471688;4756.453007904135;4758.333833263277;4777.140114779373;4797.976010119927;4975.029869175476;5041.899162016666;5046.823361182341;5068.265101560327;5071.54356107952;5190.169572868323;5201.1678131498775;5228.58171346299;5239.371275446971;5254.816081437284;5119.257707632447;5127.2052831811125;5130.12787826078;5134.306868572695;5137.588992880485;4957.107720610181;5001.049800537886;5099.5665368442615;5101.974490127525;5104.923426148685;4908.754562271801;4909.0672772173175;4921.335619691439;4929.8168439574965;4962.5533701967;5067.315912351933;5075.6193285502995;5083.440821509705;5084.135696931605;5142.202958541432;4898.461169271306;4965.900681986268;4970.726610036482;4977.726225057657;5041.067402530397 13:14:16 INFO - PROCESS | 3425 | |1;ext.html;543.7191572353063;586.741833593219;598.5301538292441;605.9303180134284;621.3879328861074;38990.415143772865;39744.20511589767;39799.80100099496;39801.80099099504;39908.80045599771;39757.40363894537;40198.79900600493;40204.79897600508;40289.19421611566;40347;7758.8448231035345;7832.334251588622;7892.684292628288;7900.407469439786;7909.288164065233;7671.232876712312;7689.923100768977;7711.652975616111;7712.57580833054;7732.381409487256;7693.576853273068;7770.533767973911;7773.9222607774045;7798.532088074705;7799.103103143126;7695.115061767884;7727.227277272284;7754.806129846743;7755.379569634416;7764.417668674843;7710.3831693464945;7837.882431763528;7854.253845884689;7858.960705196495;7866.685332586747;37728;37873.62126378728;37938.8103059483;38112;38241.61758382408;2762.392273699783;3101.42623614632;3179.2210908327374;3204.198950262434;3436.759426840122;28834;29402.85298573515;29747;29819.403611927857;30947.535786963213;3501.369753444379;3546.3971124908826;3547.6452354764574;3557.2529768748595;3616.9276614467826;245976;246846;247109;249200;250018.74990625112;31709;32772.67227327696;51285.743571281906;51286.48713512892;51334.48665513297;32859.1785205367;32955;33159;33174.83412582921;33184;12969.09216354865;13372.33138343079;13486.190828550318;13487.123336983064;13531.39108740109;10778.514966826511;10847.945760271306;10908.454577271104;10915.781684366268;10923.83614245771;7750.7674769756995;7786.1435242123325;7817.8827317590285;7918.6436610352675;7943.84112317762;3126.6716994715225;3161.2571045804216;3171.5718378019133;3184.8407579620925;3195.792273502215;857.8841856349438;881.713443130985;890.8129292848445;902.9548522573845;906.5965645287783;26613;27714.722852771214;27733.722662773114;28020;28074.578881316796;925.2281880199478;928.1924725488868;957.090763774417;1009.1674368645749;1015.3349556040805;13957.441702331997;14590.781138282935;14655.193964332064;14684.118952862862;14735;192677;192685;193829;194272;356603;48191.75904120457;48431.273530897066;48818.26772598414;48965.265521017216;49011.75494122507;1202.1404695642482;1222.8043513037871;1237.8452693413324;1246.1588427811191;1256.6292943581482;25383.6192457117;26826.731732682423;26986.325341865824;27397;27433.177004689893;42143;42748.35877461778;42841.35737963995;42928;42946.78526607347;317984;324405;324798;326129;326468;24532.754672453048;24792.504149917262;24882.004719811004;24896.751032489443;24948.37629059288;40821.1835763289;41465.79267103645;41480.170396592504;41622;42693.78653106839;35296.82351588226;35625.28749424945;35724.28551428905;35990.4601430984;36237.19509451575;35550.82224588861;35789.82105089458;36096.27807443784;36155.63844361523;36220.09449763777;34227.657723422446;34551;34956.12609684778;35400.46899296461;35460.46809297811;31106;32217.51673724849;32250;33001.33997319992;34178.65821341755;25831.741682582935;25976.350591234615;26046;26097.73902261029;26218.21345359642 13:14:16 INFO - PROCESS | 3425 | |2;jquery.html;361.8624922529439;363.1538515259444;364.857705494857;375.27009965616884;380.92191100824334;15800.68398632028;15943.681126377465;17331.91334043328;17346.826531734696;17371;16142.7578586321;16256.918715406406;16945.237464314105;17031.57421064474;17042.74435883463;5038.672486288388;5183.611229157809;5230.973845130769;5242.056429842627;5243.895122097556;4896.192128298826;5158.664686795346;5194.974025129869;5197.220416937471;5197.506236907488;5142.1772516397195;5188.766505507242;5219.608529360295;5229.346331708536;5251.737413129347;5131.486851314858;5151.278820965068;5159.968006398716;5225.712585807779;5299.364076310867;5079.034983353188;5106.106431374495;5111.3355263815465;5125.026245013472;5150.175971844487;11331;18725;19088.045597720058;20046.498837529034;20056.398308050782;1883.6891912834367;1903.1245627011454;1925.8266755992029;2002.5294055896998;2307.8846057697046;8643;8775.385722999392;9977.65078222266;10246.846297305547;13475.595732128051;1620.1818081868698;1721.3286818140934;1763.6913540130554;1780.4925596205148;1811.1306572845108;68139.65930170317;68704.3129568708;69089.3091069088;70008.29991700119;70925.64537177332;9567.760805979906;9814.607415703293;9839.704808855746;10002.949985250027;10020.34867733595;13425.664358390923;13437;13461.798073028913;13484.460621575026;13491.662708432172;6926.168859736864;6974.651267436608;7026.227115017344;7065.187503437171;7140.250273721288;6524.217093948757;6658.167729033871;6669.299723529057;6736.831579210559;6763.898541521881;4219.810108545123;4237.512686041145;4245.745255284693;4306.89232769177;4325.97837010813;1754.596442818159;1803;1803.7204233343853;1835.320931255444;1876.1463534091956;820.3847114664002;873.0265753684723;883.7083762358407;922.0318665401302;982.5332966840837;15800.762988555181;15839.604009899846;16208.918955405148;16574.17129143538;16987.830121698873;871.9825603488022;874.807542340684;882.4793371910604;895.919367256937;915.2220612479472;9170.67902623405;9442.858357124649;9465.763355916019;9496.525173741285;9523.619055237712;429454;434094;436191;437251;441269;52288.73855630698;81540;83387;83741;84029;857.511218605389;891.6477991193442;927.4249965021729;945.8912225094202;953.9618415263451;11902.761944760883;14789;14951.626209344418;14956.476523321631;15313.234338283264;36126.458103129;36916.261674766894;37055.62944370522;38234.42648360221;39595.01012474711;44573.55426445824;52641.7367913158;54500.639948803204;54503;54652;4704.964907720296;4800.927986080142;7137.357637812622;7638.6632339339285;7682.577458239851;11124.094881398252;11428.2000259981;11602.94198529002;11751.236169648946;11997.76004479888;10215.438150901475;10227.07956283938;10366.170706343626;10392.220583456423;10457.47712614351;10372.066514013775;10385;10495.580176792842;10620.681379558626;10741.194410419093;10089.798204036026;10327.32872363294;10411.271211015157;10468.790624187626;10592.311499752492;6252.812415627538;6806.863862722619;6898.586084834726;7018.122734658168;7461.81345466346;9791.902080979098;10107.898921010696;10176.745581360525;10282.588696452358;10456.529456174338 13:14:16 INFO - PROCESS | 3425 | |3;mootools.html;1359.3339263760754;1387.368747220015;1448.283099865566;1604.6309348849773;1606.1005836731438;6642.833929151773;7477.289657482537;7517.24827517248;8001.159878212791;8014.7194848180325;7602.353799927013;7857.174996625357;7887.053553573565;7891.447598668081;7928.881066783988;2147.1733382647717;2181.6618424144285;2181.8472706910525;2183.1376606240606;2187.5406164705432;2122.8514004019726;2139.8288136949086;2147.634902066645;2164.101897712447;2164.31823975448;2118.05746442833;2124.2352753008904;2130.872147671137;2133.0294715904224;2158.84888057836;2120.798524140212;2124.5219825539284;2153.7846215378495;2156.6657168138963;2158.6546152615506;2096.4968407582223;2134.7545032321327;2137.241279345825;2140.2295173737443;2145.3671167005773;7774.18371071035;7799.610019499002;7809.258120478546;7890.56601886896;7954.801129971739;4439.5560443955665;4571.519990400993;4573.336866154389;4577.588017078446;4577.702449340783;2839.417919326533;2925.0639795265524;2938.5739067835043;2938.7355138037465;2938.9559156612668;905.0949050949051;935.2611436964789;942.3026960049514;968.4721826604517;969.4086607169621;10393.636222732168;10460.581576736846;10479.47602619866;10520.368777873275;10558.260921735482;4064.288749468831;4150.335946248646;4179.791010449526;4194.2869712149;4214.957850421457;8906.242969347548;8939.73180804577;8981.955090224506;8983.775405614912;9055.547222638974;4646.744429056367;4656.278276867091;4657.510961349078;4659.394278743742;4660.300954856731;3486.790792552455;4040.9595904040584;4044.3326851069833;4077.8164982575854;4222.577742225752;3613.1147868771795;3619.113317237294;3701.981490092532;3720.1443667956523;3722.646348596879;1168.6786133813268;1169.6081812592877;1180.144395313408;1187.8158885372782;1189.9944546858064;710.5736558065223;762.1768490030754;784.9686012559548;870.7735988642871;872.5986046418592;5131.846044618667;5223.712695801767;5241.50205730455;5314.335708036496;5338.386085600128;885.4687187687337;908.2960705453195;920.406337912043;921.7511271956535;927.0173615967096;3599.6040435552068;3701.241245544657;3708.5735140458655;3719.5722491913234;3785.8296376662565;9482.288828337902;9561.569729362056;9799.755006124762;9882.11061004513;9887.703368898945;9603;9631.08504692053;9647.71056868295;9648.807023859625;9670.90329096714;7180.640967951582;7227.8554428912175;7260.782176534713;7333.706651733977;7346.302101300368;5257.4742525747115;5329.387120481039;5339.332583427072;5345.251664766858;5367.141257398954;8705.651773928972;8866.911330886609;9012.1889029985;9037.412568183046;9044.457332560067;8815.559222039;8868.467891926504;9032.277417806428;9145.725628231165;9153.725388238363;5608.4111168326735;6199.070139479114;6295.464885484785;6902.344277293649;7139.214686384597;7210.89183662235;7392.039034925425;7404.592747398945;7458.179600244077;7469.290417410337;6554.4756419485375;6559.639219842955;6662.467002639874;6662.600243985376;6766.086578311865;6551.6069035858;6589.670516474253;6592.90110648331;6633.204015517976;6642.568233065029;6195.659238741912;6227.408396202353;6248.281447633399;6259.374062593704;6267.185265915402;4337.826486940613;4463.732176069446;4505.166544189336;4549.203889319422;4600.723956562617;4541.114482675846;4549.840755573539;4571.38286331341;4596.333531637961;4651.813927442864 13:14:16 INFO - PROCESS | 3425 | |4;prototype.html;298.5491907220097;300.0638009410639;300.34974280682314;303.0816625624356;304.0574219918254;5091.592672586194;5132.460261921423;5134.768935397907;5142.562882155022;5167.715775632339;5038.294638750569;5045.949540504594;5062.468440813716;5073.492650734925;5094.1085310070775;3773.735838491307;3849.8075096245216;3951.427043078752;3951.8616848410165;3967.0957940188728;3940.2119576084897;3945.9802700986597;3963.8414463421427;3971.7021223408215;3975.165215304775;3919.157381163049;3938.4092386142165;3944.5463771666336;3950.7234493585315;3963.4649322341547;3780.9243815123546;3903.8438462461468;3944.7633142011573;3945.0334668006235;3955.8417663293435;3416.701653371703;3426.6573342665783;3437.4500079987083;3440.8451619676925;3442.8278586070596;4954.479779623124;4987.451380348159;4988.925166122511;4991.925121123186;4992.725400102993;4462.174497717932;4542.38677778499;4549.61328287096;4554.203014472454;4565.977170114162;5343.278657381243;5346.812861549866;5400.243965844785;5419.376771671269;5448.019356515825;3826.521684789401;3834.9041273968373;3837.733547929177;3845.942310865339;3852.171783066626;5417.295751552312;5655.388214358929;5695.943040569583;5706.629069110494;5707.971460142714;3892.649661530476;3894.7857867816974;3900.7074469414906;3911.8630847920185;3916.138449541096;3960.861369852099;3973.7814420206587;3975.5626881043063;3977.54258260298;3982.9601703983167;4544.409226800495;4546.931796023062;4566.086782643484;4569.405977222939;4582.900103975022;5109.4379618241965;5321.574274058066;5354.678719276856;5376.973115134399;5450.5639548836;1344.2002008804745;1349.7975303704327;1357.5995081450997;1360.6870419803304;1365.2559355151466;849.902261239953;863.3826813828143;879.7184900831672;885.1016218538189;895.9865602015975;4566.566176213254;4643.257078867365;4662.230731929261;4685;4705.482396936334;5560.082586373203;5572.5263352614675;5574.498295153375;5576.016830995479;5639.154126880919;4503.707259028152;4702.4481920966;4703.17694403478;4704.458987216514;4727;2959.4229125320358;3008.909732708022;3011.533212352089;3018.4566777980176;3020.7130322619314;5177.948220517822;5224.50367215114;5235.293235413246;5254.7635356409055;5268.341457317835;5362.2224777407055;5694.288213973254;5694.515966142924;5739.483446489836;5758.654480731086;5185.377754669464;5215.24378965048;5218.217267409843;5233.790648374099;5244.423113457593;5499;5548.390966619635;5627.493525582717;5681.318241811009;5713.200151978809;5234.685918844729;5511.834644960497;5516.834494964997;5520.723963801875;5560;5255.737213139251;5262.052830490548;5277.8416647500635;5295.523402893758;5302.522772950453;3792.905177370588;3869.5936926623426;3902.3561112416132;3907.5897030811357;3921.490206273166;5575.358833734173;5595.328560572757;5608.803691870765;5611.438856114519;5636.098224284095;5416.916616676759;5446.264754258124;5456.972715136399;5483.8080667176455;5499.450054994469;5163.321920375968;5432.158015507603;5433.9184912225555;5437.32033495813;5443.59173062014;5304.496072873071;5312.840614781563;5341.65279256847;5369.382521010134;5377.300950876361;5229.294045303987;5283.867903302448;5479.287692599936;5491.395946445808;5509.586780991362;5381.973090134525;5382.542483888757;5383.246345511553;5385.3073463268365;5411.78352865881 13:14:16 INFO - PROCESS | 3425 | |5;yui.html;646.5700309294319;667.5594107888793;693.410600989159;697.7243988624492;716.831544587022;12391.318477483735;12955.611331660042;13214.669633259173;13448.125871818325;13500.932495337522;12566.93716531416;12584;12687.175333603333;12712.300823454729;12726.745465090693;607.8267693707294;769.1961899814679;777.5723352156319;789.0097927101508;793.8055176481741;784.4783219159281;785.7603430953557;788.8974433323689;789.0767801672029;789.317240586894;834.2825170353491;837.694241601817;837.8198687282234;837.928776054033;840.0591337701752;822.0176888618104;823.2138307915985;823.950562966224;824.7031068815222;826.4669288309037;602.5661523702971;602.8613418913675;604.3171216525299;604.5314880967242;608.346028019876;12998.935005325007;13026;13093.541726039542;13100.08299419041;13124.671883202996;13032.283224422748;13274.079702465442;13347.466101355934;13387.062905596613;13438.328083595781;10372.325798823127;10500.947495262551;10533.210009249337;10762.515686794113;10781.083607893339;3267.582197174177;3292.901212963615;3318.070940136766;3333.5666363372848;3346.6987971082476;59112.40887591112;59240.11139832949;59683.70158149225;59997.800153989236;60321;10394.896051039545;10619.30974486656;10637.680869573926;10686.14510839131;10755.40845253503;19476.610467790564;19607.31374401889;19725.210991560176;19870.50323741918;19938.60122797536;6831.863362732717;6915.930840691629;6927.307269273032;6991.825204369829;7127.857442851114;3701.1672373716237;3706.0734816295926;3714.0343510687417;3756.530433695788;3776.263628592398;2690.704022557517;2834.2772592988654;2834.5039618067167;2837.205582436921;2837.9432411352072;499.97500124993604;502.86171302891995;505.45663411832425;512.4107276631903;522.2453554613547;515.6559710278839;586.0886321769689;590.2179612014013;610.2280615022;618.3383779356136;7924.881126783102;8248.422610417214;8258.215469530385;8334.749957501162;8441.155884411632;566.5835411471322;597.3817099302202;604.2809057221892;617.5868512488046;634.5050860328951;3920.941185882214;4085.5301640311745;4140.772257525865;4193.97903010483;4219.493660760729;53315.6671083226;90599;96869.5469567957;98724;98992;82579;83707.16292836994;83916.58041709752;83965;84559.57720211359;43761.56238437638;73189.26810731931;74709;77187.61406193045;77810.99999999886;7883.921160788319;8076.313513351431;8163.673453062049;8210.58947052657;8270.875936860832;42991.785041074596;43315;43456.34815477834;44358;46212.306815397125;57000;57394.71302643627;60930.39069609247;61616.38383616286;63643.68178159079;10125.038121378457;10210.693679189339;10495.212859035755;10533.631322903662;10541.525631346762;10130.848037279595;10454.32046916948;10457.633982810565;10477.266591338534;10671.146308295472;9716.951415242878;9915.355501892354;10270.486475676036;10423.68728938133;10774.784504309713;10362.326448780805;10436.060754531825;10599.258051936291;10606.840897386392;11014.559417623206;9619.18236949867;9711.854322185314;9906.306558540833;9933.106020458194;9973.30186886911;9235.353525253167;9280.814383712423;9316.627334906529;9541.427514349161;9558.474283914451;8305.95847020761;8312.376571757022;8459.661613535389;8528.275096616857;8785.385023048326 13:14:16 INFO - PROCESS | 3425 | __end_tp_report 13:14:16 INFO - PROCESS | 3425 | __start_cc_report 13:14:16 INFO - PROCESS | 3425 | _x_x_mozilla_cycle_collect,386 13:14:16 INFO - PROCESS | 3425 | __end_cc_report 13:14:16 INFO - PROCESS | 3425 | __startTimestamp1467144856102__endTimestamp 13:14:16 INFO - PROCESS | 3425 | 13:14:16 INFO - PROCESS | 3425 | ------- Summary: start ------- 13:14:16 INFO - PROCESS | 3425 | Number of tests: 6 13:14:16 INFO - PROCESS | 3425 | 13:14:16 INFO - PROCESS | 3425 | [#0] dojo.html Cycles:165 Average:4792.82 Median:4908.75 stddev:505.90 (10.3%) stddev-sans-first:478.04 13:14:16 INFO - PROCESS | 3425 | Values: 2625.8 2667.6 2674.0 2674.4 2676.8 4772.4 4788.6 4835.2 4859.5 4928.2 4712.6 4752.2 4771.8 4807.0 4830.4 4388.7 4419.7 4470.7 4479.4 4542.2 4498.6 4535.1 4535.3 4575.7 4620.6 4428.5 4457.6 4561.7 4568.2 4593.9 4451.0 4458.8 4469.6 4482.9 4495.1 4430.8 4430.9 4435.0 4445.1 4483.2 4733.9 4814.6 4820.5 4859.1 4869.1 5157.8 5169.8 5181.3 5188.8 5235.2 5254.8 5265.4 5267.2 5267.7 5309.8 4853.1 4889.6 4909.9 4911.1 4918.1 5327.7 5367.1 5376.9 5377.2 5381.0 5156.2 5161.7 5170.1 5175.0 5221.1 5076.2 5154.6 5184.7 5192.6 5199.8 5126.3 5171.0 5171.1 5177.1 5195.6 5059.5 5162.4 5174.1 5175.1 5180.4 4254.4 4393.7 4412.4 4426.1 4452.2 3801.0 3821.0 3833.2 3851.7 3857.4 4481.7 4517.3 4527.6 4530.6 4559.5 5093.0 5112.5 5116.3 5187.4 5285.1 4441.1 4460.3 4473.7 4484.7 4512.6 4660.8 4696.5 4712.3 4716.6 4740.3 4832.2 4845.1 4847.6 4862.7 4891.9 5073.9 5079.5 5106.8 5114.2 5147.5 4716.0 4756.5 4758.3 4777.1 4798.0 4975.0 5041.9 5046.8 5068.3 5071.5 5190.2 5201.2 5228.6 5239.4 5254.8 5119.3 5127.2 5130.1 5134.3 5137.6 4957.1 5001.0 5099.6 5102.0 5104.9 4908.8 4909.1 4921.3 4929.8 4962.6 5067.3 5075.6 5083.4 5084.1 5142.2 4898.5 4965.9 4970.7 4977.7 5041.1 13:14:16 INFO - PROCESS | 3425 | 13:14:16 INFO - PROCESS | 3425 | [#1] ext.html Cycles:180 Average:41628.78 Median:19504.06 stddev:71380.26 (366.0%) stddev-sans-first:71513.85 13:14:16 INFO - PROCESS | 3425 | Values: 543.7 586.7 598.5 605.9 621.4 38990.4 39744.2 39799.8 39801.8 39908.8 39757.4 40198.8 40204.8 40289.2 40347.0 7758.8 7832.3 7892.7 7900.4 7909.3 7671.2 7689.9 7711.7 7712.6 7732.4 7693.6 7770.5 7773.9 7798.5 7799.1 7695.1 7727.2 7754.8 7755.4 7764.4 7710.4 7837.9 7854.3 7859.0 7866.7 37728.0 37873.6 37938.8 38112.0 38241.6 2762.4 3101.4 3179.2 3204.2 3436.8 28834.0 29402.9 29747.0 29819.4 30947.5 3501.4 3546.4 3547.6 3557.3 3616.9 245976.0 246846.0 247109.0 249200.0 250018.7 31709.0 32772.7 51285.7 51286.5 51334.5 32859.2 32955.0 33159.0 33174.8 33184.0 12969.1 13372.3 13486.2 13487.1 13531.4 10778.5 10847.9 10908.5 10915.8 10923.8 7750.8 7786.1 7817.9 7918.6 7943.8 3126.7 3161.3 3171.6 3184.8 3195.8 857.9 881.7 890.8 903.0 906.6 26613.0 27714.7 27733.7 28020.0 28074.6 925.2 928.2 957.1 1009.2 1015.3 13957.4 14590.8 14655.2 14684.1 14735.0 192677.0 192685.0 193829.0 194272.0 356603.0 48191.8 48431.3 48818.3 48965.3 49011.8 1202.1 1222.8 1237.8 1246.2 1256.6 25383.6 26826.7 26986.3 27397.0 27433.2 42143.0 42748.4 42841.4 42928.0 42946.8 317984.0 324405.0 324798.0 326129.0 326468.0 24532.8 24792.5 24882.0 24896.8 24948.4 40821.2 41465.8 41480.2 41622.0 42693.8 35296.8 35625.3 35724.3 35990.5 36237.2 35550.8 35789.8 36096.3 36155.6 36220.1 34227.7 34551.0 34956.1 35400.5 35460.5 31106.0 32217.5 32250.0 33001.3 34178.7 25831.7 25976.4 26046.0 26097.7 26218.2 13:14:16 INFO - PROCESS | 3425 | 13:14:16 INFO - PROCESS | 3425 | [#2] jquery.html Cycles:180 Average:25426.98 Median:436721.00 stddev:71755.42 (16.4%) stddev-sans-first:71932.03 13:14:16 INFO - PROCESS | 3425 | Values: 361.9 363.2 364.9 375.3 380.9 15800.7 15943.7 17331.9 17346.8 17371.0 16142.8 16256.9 16945.2 17031.6 17042.7 5038.7 5183.6 5231.0 5242.1 5243.9 4896.2 5158.7 5195.0 5197.2 5197.5 5142.2 5188.8 5219.6 5229.3 5251.7 5131.5 5151.3 5160.0 5225.7 5299.4 5079.0 5106.1 5111.3 5125.0 5150.2 11331.0 18725.0 19088.0 20046.5 20056.4 1883.7 1903.1 1925.8 2002.5 2307.9 8643.0 8775.4 9977.7 10246.8 13475.6 1620.2 1721.3 1763.7 1780.5 1811.1 68139.7 68704.3 69089.3 70008.3 70925.6 9567.8 9814.6 9839.7 10002.9 10020.3 13425.7 13437.0 13461.8 13484.5 13491.7 6926.2 6974.7 7026.2 7065.2 7140.3 6524.2 6658.2 6669.3 6736.8 6763.9 4219.8 4237.5 4245.7 4306.9 4326.0 1754.6 1803.0 1803.7 1835.3 1876.1 820.4 873.0 883.7 922.0 982.5 15800.8 15839.6 16208.9 16574.2 16987.8 872.0 874.8 882.5 895.9 915.2 9170.7 9442.9 9465.8 9496.5 9523.6 429454.0 434094.0 436191.0 437251.0 441269.0 52288.7 81540.0 83387.0 83741.0 84029.0 857.5 891.6 927.4 945.9 954.0 11902.8 14789.0 14951.6 14956.5 15313.2 36126.5 36916.3 37055.6 38234.4 39595.0 44573.6 52641.7 54500.6 54503.0 54652.0 4705.0 4800.9 7137.4 7638.7 7682.6 11124.1 11428.2 11602.9 11751.2 11997.8 10215.4 10227.1 10366.2 10392.2 10457.5 10372.1 10385.0 10495.6 10620.7 10741.2 10089.8 10327.3 10411.3 10468.8 10592.3 6252.8 6806.9 6898.6 7018.1 7461.8 9791.9 10107.9 10176.7 10282.6 10456.5 13:14:16 INFO - PROCESS | 3425 | 13:14:16 INFO - PROCESS | 3425 | [#3] mootools.html Cycles:180 Average:5107.40 Median:5333.89 stddev:2859.40 (53.6%) stddev-sans-first:2853.55 13:14:16 INFO - PROCESS | 3425 | Values: 1359.3 1387.4 1448.3 1604.6 1606.1 6642.8 7477.3 7517.2 8001.2 8014.7 7602.4 7857.2 7887.1 7891.4 7928.9 2147.2 2181.7 2181.8 2183.1 2187.5 2122.9 2139.8 2147.6 2164.1 2164.3 2118.1 2124.2 2130.9 2133.0 2158.8 2120.8 2124.5 2153.8 2156.7 2158.7 2096.5 2134.8 2137.2 2140.2 2145.4 7774.2 7799.6 7809.3 7890.6 7954.8 4439.6 4571.5 4573.3 4577.6 4577.7 2839.4 2925.1 2938.6 2938.7 2939.0 905.1 935.3 942.3 968.5 969.4 10393.6 10460.6 10479.5 10520.4 10558.3 4064.3 4150.3 4179.8 4194.3 4215.0 8906.2 8939.7 8982.0 8983.8 9055.5 4646.7 4656.3 4657.5 4659.4 4660.3 3486.8 4041.0 4044.3 4077.8 4222.6 3613.1 3619.1 3702.0 3720.1 3722.6 1168.7 1169.6 1180.1 1187.8 1190.0 710.6 762.2 785.0 870.8 872.6 5131.8 5223.7 5241.5 5314.3 5338.4 885.5 908.3 920.4 921.8 927.0 3599.6 3701.2 3708.6 3719.6 3785.8 9482.3 9561.6 9799.8 9882.1 9887.7 9603.0 9631.1 9647.7 9648.8 9670.9 7180.6 7227.9 7260.8 7333.7 7346.3 5257.5 5329.4 5339.3 5345.3 5367.1 8705.7 8866.9 9012.2 9037.4 9044.5 8815.6 8868.5 9032.3 9145.7 9153.7 5608.4 6199.1 6295.5 6902.3 7139.2 7210.9 7392.0 7404.6 7458.2 7469.3 6554.5 6559.6 6662.5 6662.6 6766.1 6551.6 6589.7 6592.9 6633.2 6642.6 6195.7 6227.4 6248.3 6259.4 6267.2 4337.8 4463.7 4505.2 4549.2 4600.7 4541.1 4549.8 4571.4 4596.3 4651.8 13:14:16 INFO - PROCESS | 3425 | 13:14:16 INFO - PROCESS | 3425 | [#4] prototype.html Cycles:180 Average:4467.88 Median:5101.77 stddev:1318.48 (25.8%) stddev-sans-first:1284.50 13:14:16 INFO - PROCESS | 3425 | Values: 298.5 300.1 300.3 303.1 304.1 5091.6 5132.5 5134.8 5142.6 5167.7 5038.3 5045.9 5062.5 5073.5 5094.1 3773.7 3849.8 3951.4 3951.9 3967.1 3940.2 3946.0 3963.8 3971.7 3975.2 3919.2 3938.4 3944.5 3950.7 3963.5 3780.9 3903.8 3944.8 3945.0 3955.8 3416.7 3426.7 3437.5 3440.8 3442.8 4954.5 4987.5 4988.9 4991.9 4992.7 4462.2 4542.4 4549.6 4554.2 4566.0 5343.3 5346.8 5400.2 5419.4 5448.0 3826.5 3834.9 3837.7 3845.9 3852.2 5417.3 5655.4 5695.9 5706.6 5708.0 3892.6 3894.8 3900.7 3911.9 3916.1 3960.9 3973.8 3975.6 3977.5 3983.0 4544.4 4546.9 4566.1 4569.4 4582.9 5109.4 5321.6 5354.7 5377.0 5450.6 1344.2 1349.8 1357.6 1360.7 1365.3 849.9 863.4 879.7 885.1 896.0 4566.6 4643.3 4662.2 4685.0 4705.5 5560.1 5572.5 5574.5 5576.0 5639.2 4503.7 4702.4 4703.2 4704.5 4727.0 2959.4 3008.9 3011.5 3018.5 3020.7 5177.9 5224.5 5235.3 5254.8 5268.3 5362.2 5694.3 5694.5 5739.5 5758.7 5185.4 5215.2 5218.2 5233.8 5244.4 5499.0 5548.4 5627.5 5681.3 5713.2 5234.7 5511.8 5516.8 5520.7 5560.0 5255.7 5262.1 5277.8 5295.5 5302.5 3792.9 3869.6 3902.4 3907.6 3921.5 5575.4 5595.3 5608.8 5611.4 5636.1 5416.9 5446.3 5457.0 5483.8 5499.5 5163.3 5432.2 5433.9 5437.3 5443.6 5304.5 5312.8 5341.7 5369.4 5377.3 5229.3 5283.9 5479.3 5491.4 5509.6 5382.0 5382.5 5383.2 5385.3 5411.8 13:14:16 INFO - PROCESS | 3425 | 13:14:16 INFO - PROCESS | 3425 | [#5] yui.html Cycles:180 Average:16958.03 Median:29851.31 stddev:24205.46 (81.1%) stddev-sans-first:24242.38 13:14:16 INFO - PROCESS | 3425 | Values: 646.6 667.6 693.4 697.7 716.8 12391.3 12955.6 13214.7 13448.1 13500.9 12566.9 12584.0 12687.2 12712.3 12726.7 607.8 769.2 777.6 789.0 793.8 784.5 785.8 788.9 789.1 789.3 834.3 837.7 837.8 837.9 840.1 822.0 823.2 824.0 824.7 826.5 602.6 602.9 604.3 604.5 608.3 12998.9 13026.0 13093.5 13100.1 13124.7 13032.3 13274.1 13347.5 13387.1 13438.3 10372.3 10500.9 10533.2 10762.5 10781.1 3267.6 3292.9 3318.1 3333.6 3346.7 59112.4 59240.1 59683.7 59997.8 60321.0 10394.9 10619.3 10637.7 10686.1 10755.4 19476.6 19607.3 19725.2 19870.5 19938.6 6831.9 6915.9 6927.3 6991.8 7127.9 3701.2 3706.1 3714.0 3756.5 3776.3 2690.7 2834.3 2834.5 2837.2 2837.9 500.0 502.9 505.5 512.4 522.2 515.7 586.1 590.2 610.2 618.3 7924.9 8248.4 8258.2 8334.7 8441.2 566.6 597.4 604.3 617.6 634.5 3920.9 4085.5 4140.8 4194.0 4219.5 53315.7 90599.0 96869.5 98724.0 98992.0 82579.0 83707.2 83916.6 83965.0 84559.6 43761.6 73189.3 74709.0 77187.6 77811.0 7883.9 8076.3 8163.7 8210.6 8270.9 42991.8 43315.0 43456.3 44358.0 46212.3 57000.0 57394.7 60930.4 61616.4 63643.7 10125.0 10210.7 10495.2 10533.6 10541.5 10130.8 10454.3 10457.6 10477.3 10671.1 9717.0 9915.4 10270.5 10423.7 10774.8 10362.3 10436.1 10599.3 10606.8 11014.6 9619.2 9711.9 9906.3 9933.1 9973.3 9235.4 9280.8 9316.6 9541.4 9558.5 8306.0 8312.4 8459.7 8528.3 8785.4 13:14:16 INFO - PROCESS | 3425 | -------- Summary: end -------- 13:14:16 INFO - PROCESS | 3425 | 13:14:16 INFO - TEST-INFO | 3425: exit 0 13:14:16 INFO - TEST-OK | dromaeo_css | took 1119346ms 13:14:16 INFO - TEST-START | kraken 13:14:16 INFO - operating with platform_type : linux_ 13:14:16 INFO - Initialising browser for kraken test... 13:14:16 INFO - TEST-INFO | started process 3657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN08uPV/profile http://localhost:60294/getInfo.html) 13:14:21 INFO - PROCESS | 3657 | __metrics Screen width/height:1600/1200 13:14:21 INFO - PROCESS | 3657 | colorDepth:24 13:14:21 INFO - PROCESS | 3657 | Browser inner width/height: 1024/697 13:14:21 INFO - PROCESS | 3657 | __metrics 13:14:22 ERROR - PROCESS | 3657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:14:23 INFO - TEST-INFO | 3657: exit 0 13:14:23 INFO - Browser initialized. 13:14:23 INFO - Running cycle 1/1 for kraken test... 13:14:23 INFO - TEST-INFO | started process 3778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN08uPV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:35 INFO - PROCESS | 3778 | RSS: Main: 169517056 13:14:35 INFO - PROCESS | 3778 | 13:14:37 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60294/tests/kraken/driver.html?testName=audio-beat-detection) 13:14:38 INFO - PROCESS | 3778 | RSS: Main: 175185920 13:14:38 INFO - PROCESS | 3778 | 13:14:41 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60294/tests/kraken/driver.html?testName=audio-dft) 13:14:42 INFO - PROCESS | 3778 | RSS: Main: 174489600 13:14:42 INFO - PROCESS | 3778 | 13:14:45 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60294/tests/kraken/driver.html?testName=audio-fft) 13:14:45 INFO - PROCESS | 3778 | RSS: Main: 169107456 13:14:45 INFO - PROCESS | 3778 | 13:14:47 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60294/tests/kraken/driver.html?testName=audio-oscillator) 13:14:48 INFO - PROCESS | 3778 | RSS: Main: 169648128 13:14:48 INFO - PROCESS | 3778 | 13:14:50 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60294/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:51 INFO - PROCESS | 3778 | RSS: Main: 170016768 13:14:51 INFO - PROCESS | 3778 | 13:14:54 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60294/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:55 INFO - PROCESS | 3778 | RSS: Main: 170405888 13:14:55 INFO - PROCESS | 3778 | 13:14:58 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60294/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:59 INFO - PROCESS | 3778 | RSS: Main: 168058880 13:14:59 INFO - PROCESS | 3778 | 13:15:02 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60294/tests/kraken/driver.html?testName=json-parse-financial) 13:15:03 INFO - PROCESS | 3778 | RSS: Main: 169517056 13:15:03 INFO - PROCESS | 3778 | 13:15:04 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60294/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:15:05 INFO - PROCESS | 3778 | RSS: Main: 169549824 13:15:05 INFO - PROCESS | 3778 | 13:15:07 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60294/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:15:07 INFO - PROCESS | 3778 | RSS: Main: 169918464 13:15:07 INFO - PROCESS | 3778 | 13:15:10 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60294/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:15:10 INFO - PROCESS | 3778 | RSS: Main: 170373120 13:15:10 INFO - PROCESS | 3778 | 13:15:13 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:15:14 INFO - PROCESS | 3778 | RSS: Main: 170409984 13:15:14 INFO - PROCESS | 3778 | 13:15:17 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:15:17 INFO - PROCESS | 3778 | RSS: Main: 170061824 13:15:17 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:60294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60294/tests/kraken/driver.html?testName=ai-astar) 13:15:19 INFO - PROCESS | 3778 | RSS: Main: 170995712 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | __start_tp_report 13:15:19 INFO - PROCESS | 3778 | _x_x_mozilla_page_load 13:15:19 INFO - PROCESS | 3778 | _x_x_mozilla_page_load_details 13:15:19 INFO - PROCESS | 3778 | |i|pagename|runs| 13:15:19 INFO - PROCESS | 3778 | |0;ai-astar;106;114;107;112;112;113;115;113;114;115 13:15:19 INFO - PROCESS | 3778 | |1;audio-beat-detection;161;135;151;187;133;158;163;135;179;134 13:15:19 INFO - PROCESS | 3778 | |2;audio-dft;163;163;166;174;165;163;164;165;161;163 13:15:19 INFO - PROCESS | 3778 | |3;audio-fft;84;76;77;155;76;76;76;76;155;77 13:15:19 INFO - PROCESS | 3778 | |4;audio-oscillator;87;86;137;86;86;87;132;87;87;142 13:15:19 INFO - PROCESS | 3778 | |5;imaging-gaussian-blur;117;117;118;117;118;118;117;118;118;118 13:15:19 INFO - PROCESS | 3778 | |6;imaging-darkroom;147;148;147;148;146;148;148;148;147;148 13:15:19 INFO - PROCESS | 3778 | |7;imaging-desaturate;95;96;97;95;95;96;96;95;97;95 13:15:19 INFO - PROCESS | 3778 | |8;json-parse-financial;65;68;66;74;67;67;68;66;67;68 13:15:19 INFO - PROCESS | 3778 | |9;json-stringify-tinderbox;66;67;66;67;66;65;66;66;65;65 13:15:19 INFO - PROCESS | 3778 | |10;stanford-crypto-aes;82;83;89;84;85;85;90;87;92;86 13:15:19 INFO - PROCESS | 3778 | |11;stanford-crypto-ccm;133;128;130;134;137;129;138;130;132;151 13:15:19 INFO - PROCESS | 3778 | |12;stanford-crypto-pbkdf2;174;171;171;168;174;167;173;170;166;164 13:15:19 INFO - PROCESS | 3778 | |13;stanford-crypto-sha256-iterative;69;68;68;66;67;66;66;67;69;66 13:15:19 INFO - PROCESS | 3778 | __end_tp_report 13:15:19 INFO - PROCESS | 3778 | __start_cc_report 13:15:19 INFO - PROCESS | 3778 | _x_x_mozilla_cycle_collect,992 13:15:19 INFO - PROCESS | 3778 | __end_cc_report 13:15:19 INFO - PROCESS | 3778 | __startTimestamp1467144919770__endTimestamp 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | ------- Summary: start ------- 13:15:19 INFO - PROCESS | 3778 | Number of tests: 14 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:3.14 (2.8%) stddev-sans-first:2.44 13:15:19 INFO - PROCESS | 3778 | Values: 106.0 114.0 107.0 112.0 112.0 113.0 115.0 113.0 114.0 115.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:159.50 stddev:19.52 (12.2%) stddev-sans-first:20.52 13:15:19 INFO - PROCESS | 3778 | Values: 161.0 135.0 151.0 187.0 133.0 158.0 163.0 135.0 179.0 134.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:3.56 (2.2%) stddev-sans-first:3.72 13:15:19 INFO - PROCESS | 3778 | Values: 163.0 163.0 166.0 174.0 165.0 163.0 164.0 165.0 161.0 163.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:32.87 (43.3%) stddev-sans-first:34.71 13:15:19 INFO - PROCESS | 3778 | Values: 84.0 76.0 77.0 155.0 76.0 76.0 76.0 76.0 155.0 77.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:86.50 stddev:24.48 (28.3%) stddev-sans-first:25.38 13:15:19 INFO - PROCESS | 3778 | Values: 87.0 86.0 137.0 86.0 86.0 87.0 132.0 87.0 87.0 142.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:15:19 INFO - PROCESS | 3778 | Values: 117.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 118.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 13:15:19 INFO - PROCESS | 3778 | Values: 147.0 148.0 147.0 148.0 146.0 148.0 148.0 148.0 147.0 148.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 13:15:19 INFO - PROCESS | 3778 | Values: 95.0 96.0 97.0 95.0 95.0 96.0 96.0 95.0 97.0 95.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:67.50 stddev:2.46 (3.6%) stddev-sans-first:2.42 13:15:19 INFO - PROCESS | 3778 | Values: 65.0 68.0 66.0 74.0 67.0 67.0 68.0 66.0 67.0 68.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 13:15:19 INFO - PROCESS | 3778 | Values: 66.0 67.0 66.0 67.0 66.0 65.0 66.0 66.0 65.0 65.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:3.20 (3.7%) stddev-sans-first:2.99 13:15:19 INFO - PROCESS | 3778 | Values: 82.0 83.0 89.0 84.0 85.0 85.0 90.0 87.0 92.0 86.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:133.50 stddev:6.76 (5.1%) stddev-sans-first:7.16 13:15:19 INFO - PROCESS | 3778 | Values: 133.0 128.0 130.0 134.0 137.0 129.0 138.0 130.0 132.0 151.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:171.00 stddev:3.46 (2.0%) stddev-sans-first:3.32 13:15:19 INFO - PROCESS | 3778 | Values: 174.0 171.0 171.0 168.0 174.0 167.0 173.0 170.0 166.0 164.0 13:15:19 INFO - PROCESS | 3778 | 13:15:19 INFO - PROCESS | 3778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.23 (1.8%) stddev-sans-first:1.12 13:15:19 INFO - PROCESS | 3778 | Values: 69.0 68.0 68.0 66.0 67.0 66.0 66.0 67.0 69.0 66.0 13:15:19 INFO - PROCESS | 3778 | -------- Summary: end -------- 13:15:19 INFO - PROCESS | 3778 | 13:15:20 INFO - TEST-INFO | 3778: exit 0 13:15:20 INFO - TEST-OK | kraken | took 63943ms 13:15:20 INFO - SUITE-END | took 1183s 13:15:20 INFO - Completed test suite (00:19:43) 13:15:20 INFO - javascript benchmark 13:15:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6358.288389655605, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.816192866499, 2667.6265322854792, 2674.0, 2674.4249986252953, 2676.772474339681, 4772.427308722949, 4788.616910647144, 4835.226363781791, 4859.514048595139, 4928.211486162215, 4712.5758681718635, 4752.168370535152, 4771.785269662865, 4806.9519304806945, 4830.396200474941, 4388.714733542325, 4419.712718673276, 4470.687051906351, 4479.372887795711, 4542.15970045541, 4498.617617502517, 4535.092981403716, 4535.297028960516, 4575.725456472605, 4620.5610467005745, 4428.512863585003, 4457.64338852891, 4561.657875659323, 4568.2462393705, 4593.908121837561, 4450.977745111254, 4458.777061146962, 4469.620082293009, 4482.910341793178, 4495.1009798040195, 4430.800613972347, 4430.911381772379, 4435.0, 4445.066536027438, 4483.21543729846, 4733.905321893543, 4814.590759785422, 4820.517948205152, 4859.149648811479, 4869.099216644897, 5157.767900444489, 5169.767360468788, 5181.326427564392, 5188.766505507224, 5235.188545775411, 5254.763535640867, 5265.447128051576, 5267.236250743621, 5267.710275934822, 5309.787608495655, 4853.0779151961015, 4889.633277504201, 4909.87725306863, 4911.091448082152, 4918.114739346916, 5327.680339179584, 5367.141257398797, 5376.91934620981, 5377.24718539397, 5381.0, 5156.20078887773, 5161.66449180802, 5170.069387510209, 5175.0, 5221.060209162311, 5076.238564215398, 5154.639175257696, 5184.7407629618365, 5192.584593232608, 5199.818006369759, 5126.282320475137, 5171.043356978971, 5171.095058364771, 5177.094008548489, 5195.558377537876, 5059.519345662156, 5162.380514338303, 5174.120399532088, 5175.094358487325, 5180.352455943007, 4254.446921900133, 4393.6704747144095, 4412.426384569985, 4426.070525189746, 4452.198604251201, 3800.9809950950066, 3821.0256384621744, 3833.1758671885677, 3851.672607828366, 3857.4406711027304, 4481.663875209372, 4517.344984977226, 4527.569880861313, 4530.569595888385, 4559.475660299108, 5092.9745351273, 5112.463191364927, 5116.258142569381, 5187.429382767892, 5285.101532739443, 4441.089576636782, 4460.264056430718, 4473.664475164375, 4484.708493947883, 4512.616427603625, 4660.813567457264, 4696.483386827446, 4712.269598212282, 4716.622670186377, 4740.312654665055, 4832.1543729847135, 4845.103655823684, 4847.61219102478, 4862.708237505761, 4891.902161956741, 5073.898522029465, 5079.517445842639, 5106.821261255838, 5114.15616423286, 5147.510986456281, 4715.952840471688, 4756.453007904135, 4758.333833263277, 4777.140114779373, 4797.976010119927, 4975.029869175476, 5041.899162016666, 5046.823361182341, 5068.265101560327, 5071.54356107952, 5190.169572868323, 5201.1678131498775, 5228.58171346299, 5239.371275446971, 5254.816081437284, 5119.257707632447, 5127.2052831811125, 5130.12787826078, 5134.306868572695, 5137.588992880485, 4957.107720610181, 5001.049800537886, 5099.5665368442615, 5101.974490127525, 5104.923426148685, 4908.754562271801, 4909.0672772173175, 4921.335619691439, 4929.8168439574965, 4962.5533701967, 5067.315912351933, 5075.6193285502995, 5083.440821509705, 5084.135696931605, 5142.202958541432, 4898.461169271306, 4965.900681986268, 4970.726610036482, 4977.726225057657, 5041.067402530397], "value": 4759.850857699538, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.7191572353063, 586.741833593219, 598.5301538292441, 605.9303180134284, 621.3879328861074, 38990.415143772865, 39744.20511589767, 39799.80100099496, 39801.80099099504, 39908.80045599771, 39757.40363894537, 40198.79900600493, 40204.79897600508, 40289.19421611566, 40347.0, 7758.8448231035345, 7832.334251588622, 7892.684292628288, 7900.407469439786, 7909.288164065233, 7671.232876712312, 7689.923100768977, 7711.652975616111, 7712.57580833054, 7732.381409487256, 7693.576853273068, 7770.533767973911, 7773.9222607774045, 7798.532088074705, 7799.103103143126, 7695.115061767884, 7727.227277272284, 7754.806129846743, 7755.379569634416, 7764.417668674843, 7710.3831693464945, 7837.882431763528, 7854.253845884689, 7858.960705196495, 7866.685332586747, 37728.0, 37873.62126378728, 37938.8103059483, 38112.0, 38241.61758382408, 2762.392273699783, 3101.42623614632, 3179.2210908327374, 3204.198950262434, 3436.759426840122, 28834.0, 29402.85298573515, 29747.0, 29819.403611927857, 30947.535786963213, 3501.369753444379, 3546.3971124908826, 3547.6452354764574, 3557.2529768748595, 3616.9276614467826, 245976.0, 246846.0, 247109.0, 249200.0, 250018.74990625112, 31709.0, 32772.67227327696, 51285.743571281906, 51286.48713512892, 51334.48665513297, 32859.1785205367, 32955.0, 33159.0, 33174.83412582921, 33184.0, 12969.09216354865, 13372.33138343079, 13486.190828550318, 13487.123336983064, 13531.39108740109, 10778.514966826511, 10847.945760271306, 10908.454577271104, 10915.781684366268, 10923.83614245771, 7750.7674769756995, 7786.1435242123325, 7817.8827317590285, 7918.6436610352675, 7943.84112317762, 3126.6716994715225, 3161.2571045804216, 3171.5718378019133, 3184.8407579620925, 3195.792273502215, 857.8841856349438, 881.713443130985, 890.8129292848445, 902.9548522573845, 906.5965645287783, 26613.0, 27714.722852771214, 27733.722662773114, 28020.0, 28074.578881316796, 925.2281880199478, 928.1924725488868, 957.090763774417, 1009.1674368645749, 1015.3349556040805, 13957.441702331997, 14590.781138282935, 14655.193964332064, 14684.118952862862, 14735.0, 192677.0, 192685.0, 193829.0, 194272.0, 356603.0, 48191.75904120457, 48431.273530897066, 48818.26772598414, 48965.265521017216, 49011.75494122507, 1202.1404695642482, 1222.8043513037871, 1237.8452693413324, 1246.1588427811191, 1256.6292943581482, 25383.6192457117, 26826.731732682423, 26986.325341865824, 27397.0, 27433.177004689893, 42143.0, 42748.35877461778, 42841.35737963995, 42928.0, 42946.78526607347, 317984.0, 324405.0, 324798.0, 326129.0, 326468.0, 24532.754672453048, 24792.504149917262, 24882.004719811004, 24896.751032489443, 24948.37629059288, 40821.1835763289, 41465.79267103645, 41480.170396592504, 41622.0, 42693.78653106839, 35296.82351588226, 35625.28749424945, 35724.28551428905, 35990.4601430984, 36237.19509451575, 35550.82224588861, 35789.82105089458, 36096.27807443784, 36155.63844361523, 36220.09449763777, 34227.657723422446, 34551.0, 34956.12609684778, 35400.46899296461, 35460.46809297811, 31106.0, 32217.51673724849, 32250.0, 33001.33997319992, 34178.65821341755, 25831.741682582935, 25976.350591234615, 26046.0, 26097.73902261029, 26218.21345359642], "value": 16131.201281412594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8624922529439, 363.1538515259444, 364.857705494857, 375.27009965616884, 380.92191100824334, 15800.68398632028, 15943.681126377465, 17331.91334043328, 17346.826531734696, 17371.0, 16142.7578586321, 16256.918715406406, 16945.237464314105, 17031.57421064474, 17042.74435883463, 5038.672486288388, 5183.611229157809, 5230.973845130769, 5242.056429842627, 5243.895122097556, 4896.192128298826, 5158.664686795346, 5194.974025129869, 5197.220416937471, 5197.506236907488, 5142.1772516397195, 5188.766505507242, 5219.608529360295, 5229.346331708536, 5251.737413129347, 5131.486851314858, 5151.278820965068, 5159.968006398716, 5225.712585807779, 5299.364076310867, 5079.034983353188, 5106.106431374495, 5111.3355263815465, 5125.026245013472, 5150.175971844487, 11331.0, 18725.0, 19088.045597720058, 20046.498837529034, 20056.398308050782, 1883.6891912834367, 1903.1245627011454, 1925.8266755992029, 2002.5294055896998, 2307.8846057697046, 8643.0, 8775.385722999392, 9977.65078222266, 10246.846297305547, 13475.595732128051, 1620.1818081868698, 1721.3286818140934, 1763.6913540130554, 1780.4925596205148, 1811.1306572845108, 68139.65930170317, 68704.3129568708, 69089.3091069088, 70008.29991700119, 70925.64537177332, 9567.760805979906, 9814.607415703293, 9839.704808855746, 10002.949985250027, 10020.34867733595, 13425.664358390923, 13437.0, 13461.798073028913, 13484.460621575026, 13491.662708432172, 6926.168859736864, 6974.651267436608, 7026.227115017344, 7065.187503437171, 7140.250273721288, 6524.217093948757, 6658.167729033871, 6669.299723529057, 6736.831579210559, 6763.898541521881, 4219.810108545123, 4237.512686041145, 4245.745255284693, 4306.89232769177, 4325.97837010813, 1754.596442818159, 1803.0, 1803.7204233343853, 1835.320931255444, 1876.1463534091956, 820.3847114664002, 873.0265753684723, 883.7083762358407, 922.0318665401302, 982.5332966840837, 15800.762988555181, 15839.604009899846, 16208.918955405148, 16574.17129143538, 16987.830121698873, 871.9825603488022, 874.807542340684, 882.4793371910604, 895.919367256937, 915.2220612479472, 9170.67902623405, 9442.858357124649, 9465.763355916019, 9496.525173741285, 9523.619055237712, 429454.0, 434094.0, 436191.0, 437251.0, 441269.0, 52288.73855630698, 81540.0, 83387.0, 83741.0, 84029.0, 857.511218605389, 891.6477991193442, 927.4249965021729, 945.8912225094202, 953.9618415263451, 11902.761944760883, 14789.0, 14951.626209344418, 14956.476523321631, 15313.234338283264, 36126.458103129, 36916.261674766894, 37055.62944370522, 38234.42648360221, 39595.01012474711, 44573.55426445824, 52641.7367913158, 54500.639948803204, 54503.0, 54652.0, 4704.964907720296, 4800.927986080142, 7137.357637812622, 7638.6632339339285, 7682.577458239851, 11124.094881398252, 11428.2000259981, 11602.94198529002, 11751.236169648946, 11997.76004479888, 10215.438150901475, 10227.07956283938, 10366.170706343626, 10392.220583456423, 10457.47712614351, 10372.066514013775, 10385.0, 10495.580176792842, 10620.681379558626, 10741.194410419093, 10089.798204036026, 10327.32872363294, 10411.271211015157, 10468.790624187626, 10592.311499752492, 6252.812415627538, 6806.863862722619, 6898.586084834726, 7018.122734658168, 7461.81345466346, 9791.902080979098, 10107.898921010696, 10176.745581360525, 10282.588696452358, 10456.529456174338], "value": 8097.45577191957, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.3339263760754, 1387.368747220015, 1448.283099865566, 1604.6309348849773, 1606.1005836731438, 6642.833929151773, 7477.289657482537, 7517.24827517248, 8001.159878212791, 8014.7194848180325, 7602.353799927013, 7857.174996625357, 7887.053553573565, 7891.447598668081, 7928.881066783988, 2147.1733382647717, 2181.6618424144285, 2181.8472706910525, 2183.1376606240606, 2187.5406164705432, 2122.8514004019726, 2139.8288136949086, 2147.634902066645, 2164.101897712447, 2164.31823975448, 2118.05746442833, 2124.2352753008904, 2130.872147671137, 2133.0294715904224, 2158.84888057836, 2120.798524140212, 2124.5219825539284, 2153.7846215378495, 2156.6657168138963, 2158.6546152615506, 2096.4968407582223, 2134.7545032321327, 2137.241279345825, 2140.2295173737443, 2145.3671167005773, 7774.18371071035, 7799.610019499002, 7809.258120478546, 7890.56601886896, 7954.801129971739, 4439.5560443955665, 4571.519990400993, 4573.336866154389, 4577.588017078446, 4577.702449340783, 2839.417919326533, 2925.0639795265524, 2938.5739067835043, 2938.7355138037465, 2938.9559156612668, 905.0949050949051, 935.2611436964789, 942.3026960049514, 968.4721826604517, 969.4086607169621, 10393.636222732168, 10460.581576736846, 10479.47602619866, 10520.368777873275, 10558.260921735482, 4064.288749468831, 4150.335946248646, 4179.791010449526, 4194.2869712149, 4214.957850421457, 8906.242969347548, 8939.73180804577, 8981.955090224506, 8983.775405614912, 9055.547222638974, 4646.744429056367, 4656.278276867091, 4657.510961349078, 4659.394278743742, 4660.300954856731, 3486.790792552455, 4040.9595904040584, 4044.3326851069833, 4077.8164982575854, 4222.577742225752, 3613.1147868771795, 3619.113317237294, 3701.981490092532, 3720.1443667956523, 3722.646348596879, 1168.6786133813268, 1169.6081812592877, 1180.144395313408, 1187.8158885372782, 1189.9944546858064, 710.5736558065223, 762.1768490030754, 784.9686012559548, 870.7735988642871, 872.5986046418592, 5131.846044618667, 5223.712695801767, 5241.50205730455, 5314.335708036496, 5338.386085600128, 885.4687187687337, 908.2960705453195, 920.406337912043, 921.7511271956535, 927.0173615967096, 3599.6040435552068, 3701.241245544657, 3708.5735140458655, 3719.5722491913234, 3785.8296376662565, 9482.288828337902, 9561.569729362056, 9799.755006124762, 9882.11061004513, 9887.703368898945, 9603.0, 9631.08504692053, 9647.71056868295, 9648.807023859625, 9670.90329096714, 7180.640967951582, 7227.8554428912175, 7260.782176534713, 7333.706651733977, 7346.302101300368, 5257.4742525747115, 5329.387120481039, 5339.332583427072, 5345.251664766858, 5367.141257398954, 8705.651773928972, 8866.911330886609, 9012.1889029985, 9037.412568183046, 9044.457332560067, 8815.559222039, 8868.467891926504, 9032.277417806428, 9145.725628231165, 9153.725388238363, 5608.4111168326735, 6199.070139479114, 6295.464885484785, 6902.344277293649, 7139.214686384597, 7210.89183662235, 7392.039034925425, 7404.592747398945, 7458.179600244077, 7469.290417410337, 6554.4756419485375, 6559.639219842955, 6662.467002639874, 6662.600243985376, 6766.086578311865, 6551.6069035858, 6589.670516474253, 6592.90110648331, 6633.204015517976, 6642.568233065029, 6195.659238741912, 6227.408396202353, 6248.281447633399, 6259.374062593704, 6267.185265915402, 4337.826486940613, 4463.732176069446, 4505.166544189336, 4549.203889319422, 4600.723956562617, 4541.114482675846, 4549.840755573539, 4571.38286331341, 4596.333531637961, 4651.813927442864], "value": 4119.571378889162, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.5491907220097, 300.0638009410639, 300.34974280682314, 303.0816625624356, 304.0574219918254, 5091.592672586194, 5132.460261921423, 5134.768935397907, 5142.562882155022, 5167.715775632339, 5038.294638750569, 5045.949540504594, 5062.468440813716, 5073.492650734925, 5094.1085310070775, 3773.735838491307, 3849.8075096245216, 3951.427043078752, 3951.8616848410165, 3967.0957940188728, 3940.2119576084897, 3945.9802700986597, 3963.8414463421427, 3971.7021223408215, 3975.165215304775, 3919.157381163049, 3938.4092386142165, 3944.5463771666336, 3950.7234493585315, 3963.4649322341547, 3780.9243815123546, 3903.8438462461468, 3944.7633142011573, 3945.0334668006235, 3955.8417663293435, 3416.701653371703, 3426.6573342665783, 3437.4500079987083, 3440.8451619676925, 3442.8278586070596, 4954.479779623124, 4987.451380348159, 4988.925166122511, 4991.925121123186, 4992.725400102993, 4462.174497717932, 4542.38677778499, 4549.61328287096, 4554.203014472454, 4565.977170114162, 5343.278657381243, 5346.812861549866, 5400.243965844785, 5419.376771671269, 5448.019356515825, 3826.521684789401, 3834.9041273968373, 3837.733547929177, 3845.942310865339, 3852.171783066626, 5417.295751552312, 5655.388214358929, 5695.943040569583, 5706.629069110494, 5707.971460142714, 3892.649661530476, 3894.7857867816974, 3900.7074469414906, 3911.8630847920185, 3916.138449541096, 3960.861369852099, 3973.7814420206587, 3975.5626881043063, 3977.54258260298, 3982.9601703983167, 4544.409226800495, 4546.931796023062, 4566.086782643484, 4569.405977222939, 4582.900103975022, 5109.4379618241965, 5321.574274058066, 5354.678719276856, 5376.973115134399, 5450.5639548836, 1344.2002008804745, 1349.7975303704327, 1357.5995081450997, 1360.6870419803304, 1365.2559355151466, 849.902261239953, 863.3826813828143, 879.7184900831672, 885.1016218538189, 895.9865602015975, 4566.566176213254, 4643.257078867365, 4662.230731929261, 4685.0, 4705.482396936334, 5560.082586373203, 5572.5263352614675, 5574.498295153375, 5576.016830995479, 5639.154126880919, 4503.707259028152, 4702.4481920966, 4703.17694403478, 4704.458987216514, 4727.0, 2959.4229125320358, 3008.909732708022, 3011.533212352089, 3018.4566777980176, 3020.7130322619314, 5177.948220517822, 5224.50367215114, 5235.293235413246, 5254.7635356409055, 5268.341457317835, 5362.2224777407055, 5694.288213973254, 5694.515966142924, 5739.483446489836, 5758.654480731086, 5185.377754669464, 5215.24378965048, 5218.217267409843, 5233.790648374099, 5244.423113457593, 5499.0, 5548.390966619635, 5627.493525582717, 5681.318241811009, 5713.200151978809, 5234.685918844729, 5511.834644960497, 5516.834494964997, 5520.723963801875, 5560.0, 5255.737213139251, 5262.052830490548, 5277.8416647500635, 5295.523402893758, 5302.522772950453, 3792.905177370588, 3869.5936926623426, 3902.3561112416132, 3907.5897030811357, 3921.490206273166, 5575.358833734173, 5595.328560572757, 5608.803691870765, 5611.438856114519, 5636.098224284095, 5416.916616676759, 5446.264754258124, 5456.972715136399, 5483.8080667176455, 5499.450054994469, 5163.321920375968, 5432.158015507603, 5433.9184912225555, 5437.32033495813, 5443.59173062014, 5304.496072873071, 5312.840614781563, 5341.65279256847, 5369.382521010134, 5377.300950876361, 5229.294045303987, 5283.867903302448, 5479.287692599936, 5491.395946445808, 5509.586780991362, 5381.973090134525, 5382.542483888757, 5383.246345511553, 5385.3073463268365, 5411.78352865881], "value": 4041.2240994226863, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.5700309294319, 667.5594107888793, 693.410600989159, 697.7243988624492, 716.831544587022, 12391.318477483735, 12955.611331660042, 13214.669633259173, 13448.125871818325, 13500.932495337522, 12566.93716531416, 12584.0, 12687.175333603333, 12712.300823454729, 12726.745465090693, 607.8267693707294, 769.1961899814679, 777.5723352156319, 789.0097927101508, 793.8055176481741, 784.4783219159281, 785.7603430953557, 788.8974433323689, 789.0767801672029, 789.317240586894, 834.2825170353491, 837.694241601817, 837.8198687282234, 837.928776054033, 840.0591337701752, 822.0176888618104, 823.2138307915985, 823.950562966224, 824.7031068815222, 826.4669288309037, 602.5661523702971, 602.8613418913675, 604.3171216525299, 604.5314880967242, 608.346028019876, 12998.935005325007, 13026.0, 13093.541726039542, 13100.08299419041, 13124.671883202996, 13032.283224422748, 13274.079702465442, 13347.466101355934, 13387.062905596613, 13438.328083595781, 10372.325798823127, 10500.947495262551, 10533.210009249337, 10762.515686794113, 10781.083607893339, 3267.582197174177, 3292.901212963615, 3318.070940136766, 3333.5666363372848, 3346.6987971082476, 59112.40887591112, 59240.11139832949, 59683.70158149225, 59997.800153989236, 60321.0, 10394.896051039545, 10619.30974486656, 10637.680869573926, 10686.14510839131, 10755.40845253503, 19476.610467790564, 19607.31374401889, 19725.210991560176, 19870.50323741918, 19938.60122797536, 6831.863362732717, 6915.930840691629, 6927.307269273032, 6991.825204369829, 7127.857442851114, 3701.1672373716237, 3706.0734816295926, 3714.0343510687417, 3756.530433695788, 3776.263628592398, 2690.704022557517, 2834.2772592988654, 2834.5039618067167, 2837.205582436921, 2837.9432411352072, 499.97500124993604, 502.86171302891995, 505.45663411832425, 512.4107276631903, 522.2453554613547, 515.6559710278839, 586.0886321769689, 590.2179612014013, 610.2280615022, 618.3383779356136, 7924.881126783102, 8248.422610417214, 8258.215469530385, 8334.749957501162, 8441.155884411632, 566.5835411471322, 597.3817099302202, 604.2809057221892, 617.5868512488046, 634.5050860328951, 3920.941185882214, 4085.5301640311745, 4140.772257525865, 4193.97903010483, 4219.493660760729, 53315.6671083226, 90599.0, 96869.5469567957, 98724.0, 98992.0, 82579.0, 83707.16292836994, 83916.58041709752, 83965.0, 84559.57720211359, 43761.56238437638, 73189.26810731931, 74709.0, 77187.61406193045, 77810.99999999886, 7883.921160788319, 8076.313513351431, 8163.673453062049, 8210.58947052657, 8270.875936860832, 42991.785041074596, 43315.0, 43456.34815477834, 44358.0, 46212.306815397125, 57000.0, 57394.71302643627, 60930.39069609247, 61616.38383616286, 63643.68178159079, 10125.038121378457, 10210.693679189339, 10495.212859035755, 10533.631322903662, 10541.525631346762, 10130.848037279595, 10454.32046916948, 10457.633982810565, 10477.266591338534, 10671.146308295472, 9716.951415242878, 9915.355501892354, 10270.486475676036, 10423.68728938133, 10774.784504309713, 10362.326448780805, 10436.060754531825, 10599.258051936291, 10606.840897386392, 11014.559417623206, 9619.18236949867, 9711.854322185314, 9906.306558540833, 9933.106020458194, 9973.30186886911, 9235.353525253167, 9280.814383712423, 9316.627334906529, 9541.427514349161, 9558.474283914451, 8305.95847020761, 8312.376571757022, 8459.661613535389, 8528.275096616857, 8785.385023048326], "value": 6382.999883583885, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 107.0, 112.0, 112.0, 113.0, 115.0, 113.0, 114.0, 115.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 135.0, 151.0, 187.0, 133.0, 158.0, 163.0, 135.0, 179.0, 134.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 166.0, 174.0, 165.0, 163.0, 164.0, 165.0, 161.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 77.0, 155.0, 76.0, 76.0, 76.0, 76.0, 155.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 137.0, 86.0, 86.0, 87.0, 132.0, 87.0, 87.0, 142.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 146.0, 148.0, 148.0, 148.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 74.0, 67.0, 67.0, 68.0, 66.0, 67.0, 68.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 89.0, 84.0, 85.0, 85.0, 90.0, 87.0, 92.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 130.0, 134.0, 137.0, 129.0, 138.0, 130.0, 132.0, 151.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 171.0, 168.0, 174.0, 167.0, 173.0, 170.0, 166.0, 164.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 66.0, 67.0, 66.0, 66.0, 67.0, 69.0, 66.0], "value": 67.2, "unit": "score"}]}]} 13:15:21 INFO - Return code: 0 13:15:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:15:21 ERROR - # TBPL SUCCESS # 13:15:21 INFO - Running post-action listener: _resource_record_post_action 13:15:21 INFO - ##### 13:15:21 INFO - ##### Finished run-tests step (success) 13:15:21 INFO - ##### 13:15:21 INFO - Running post-run listener: _resource_record_post_run 13:15:21 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7651328; Write bytes: 365219840; Read time: 1076; Write time: 283528 13:15:21 INFO - TinderboxPrint: CPU usage
13.4% 13:15:21 INFO - TinderboxPrint: I/O read bytes / time
7,651,328 / 1,076 13:15:21 INFO - TinderboxPrint: I/O write bytes / time
365,219,840 / 283,528 13:15:21 INFO - TinderboxPrint: CPU idle
8,289.6 (86.6%) 13:15:21 INFO - TinderboxPrint: CPU user
1,228.3 (12.8%) 13:15:21 INFO - TinderboxPrint: Swap in / out
0 / 0 13:15:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 6275072; Read time: 0; Write time: 448 13:15:21 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5419008; Write bytes: 358944768; Read time: 876; Write time: 283080 13:15:21 INFO - Running post-run listener: _upload_blobber_files 13:15:21 INFO - Blob upload gear active. 13:15:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:15:21 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:21 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:21 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:22 INFO - (blobuploader) - INFO - Open directory for files ... 13:15:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:15:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:15:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:22 INFO - (blobuploader) - INFO - Done attempting. 13:15:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:15:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:15:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:23 INFO - (blobuploader) - INFO - Done attempting. 13:15:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:15:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:15:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:27 INFO - (blobuploader) - INFO - Done attempting. 13:15:27 INFO - (blobuploader) - INFO - Iteration through files over. 13:15:27 INFO - Return code: 0 13:15:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:15:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:15:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7b15156ee365b17845d6a909e151ac6a71318a1a5ebbb43f9e7f1e1951f0b338e97644c39f2e788c4e3bd664601478a84dd0a77c116c6f5750ba6b599bec83c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/be0763ce00c0be97707cc4ffe89c40fb31ab8b2fd1832fcabe7bf61466692867735b4bbb00e9eeeb9a264a5e7cc033d04a33f8d46f0dc85921d4e666aa181333", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8a7e6a1eb78af365a02ea828e77c308a6fb406d165a9736c00619d774e95ac7d3daebe3cb9c447894f5c0a50f8513ed2c8738e42201c0bd7122e094b19d96673"} 13:15:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:15:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:15:27 INFO - Contents: 13:15:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7b15156ee365b17845d6a909e151ac6a71318a1a5ebbb43f9e7f1e1951f0b338e97644c39f2e788c4e3bd664601478a84dd0a77c116c6f5750ba6b599bec83c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/be0763ce00c0be97707cc4ffe89c40fb31ab8b2fd1832fcabe7bf61466692867735b4bbb00e9eeeb9a264a5e7cc033d04a33f8d46f0dc85921d4e666aa181333", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8a7e6a1eb78af365a02ea828e77c308a6fb406d165a9736c00619d774e95ac7d3daebe3cb9c447894f5c0a50f8513ed2c8738e42201c0bd7122e094b19d96673"} 13:15:27 INFO - Running post-run listener: copy_logs_to_upload_dir 13:15:27 INFO - Copying logs to upload dir... 13:15:27 INFO - mkdir: /builds/slave/test/build/upload/logs 13:15:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.703633 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-06-28 13:15:27.967558) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 13:15:27.970683) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7b15156ee365b17845d6a909e151ac6a71318a1a5ebbb43f9e7f1e1951f0b338e97644c39f2e788c4e3bd664601478a84dd0a77c116c6f5750ba6b599bec83c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/be0763ce00c0be97707cc4ffe89c40fb31ab8b2fd1832fcabe7bf61466692867735b4bbb00e9eeeb9a264a5e7cc033d04a33f8d46f0dc85921d4e666aa181333", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8a7e6a1eb78af365a02ea828e77c308a6fb406d165a9736c00619d774e95ac7d3daebe3cb9c447894f5c0a50f8513ed2c8738e42201c0bd7122e094b19d96673"} 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.011167 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7b15156ee365b17845d6a909e151ac6a71318a1a5ebbb43f9e7f1e1951f0b338e97644c39f2e788c4e3bd664601478a84dd0a77c116c6f5750ba6b599bec83c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/be0763ce00c0be97707cc4ffe89c40fb31ab8b2fd1832fcabe7bf61466692867735b4bbb00e9eeeb9a264a5e7cc033d04a33f8d46f0dc85921d4e666aa181333", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8a7e6a1eb78af365a02ea828e77c308a6fb406d165a9736c00619d774e95ac7d3daebe3cb9c447894f5c0a50f8513ed2c8738e42201c0bd7122e094b19d96673"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 13:15:27.995685) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 13:15:27.996000) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467143465.882840-148538673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 13:15:28.080509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 13:15:28.080820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 13:15:28.081145) ========= ========= Total master_lag: 0.33 =========