builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1472500035.26 results: success (0) buildid: 20160829115230 builduid: e6942d70d2144a79951f9c306fbd7350 revision: fa10bd34b8f7cbfbe275c6ebe9a33b583e179b3a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:15.258678) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:15.259146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:15.259435) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:15.314340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:15.314610) ========= 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=db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 12:47:16-- 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% 45.7M=0s 2016-08-29 12:47:16 (45.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123174 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:15.465652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:15.465971) ========= 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=db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017992 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:15.522984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:15.523329) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev fa10bd34b8f7cbfbe275c6ebe9a33b583e179b3a --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 fa10bd34b8f7cbfbe275c6ebe9a33b583e179b3a --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=db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 12:47:16,570 truncating revision to first 12 chars 2016-08-29 12:47:16,570 Setting DEBUG logging. 2016-08-29 12:47:16,570 attempt 1/10 2016-08-29 12:47:16,570 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/fa10bd34b8f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 12:47:16,824 unpacking tar archive at: autoland-fa10bd34b8f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529697 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:16.067920) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:16.068261) ========= script_repo_revision: fa10bd34b8f7cbfbe275c6ebe9a33b583e179b3a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:16.068665) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:16.068973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 12:47:16.081363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-29 12:47:16.081644) ========= /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=db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:47:17 INFO - MultiFileLogger online at 20160829 12:47:17 in /builds/slave/test 12:47:17 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:47:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:47:17 INFO - {'append_to_log': False, 12:47:17 INFO - 'base_work_dir': '/builds/slave/test', 12:47:17 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:47:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:47:17 INFO - 'branch': 'Autoland-Non-PGO', 12:47:17 INFO - 'buildbot_json_path': 'buildprops.json', 12:47:17 INFO - 'config_files': ('talos/linux_config.py',), 12:47:17 INFO - 'default_actions': ('clobber', 12:47:17 INFO - 'read-buildbot-config', 12:47:17 INFO - 'download-and-extract', 12:47:17 INFO - 'populate-webroot', 12:47:17 INFO - 'create-virtualenv', 12:47:17 INFO - 'install', 12:47:17 INFO - 'run-tests'), 12:47:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:47:17 INFO - 'download_minidump_stackwalk': True, 12:47:17 INFO - 'download_symbols': 'ondemand', 12:47:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:47:17 INFO - 'tooltool.py': '/tools/tooltool.py', 12:47:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:47:17 INFO - '/tools/misc-python/virtualenv.py')}, 12:47:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:47:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:47:17 INFO - 'installer_path': 'installer.exe', 12:47:17 INFO - 'log_level': 'info', 12:47:17 INFO - 'log_name': 'talos', 12:47:17 INFO - 'log_to_console': True, 12:47:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:47:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:47:17 INFO - 'opt_config_files': (), 12:47:17 INFO - 'pip_index': False, 12:47:17 INFO - 'sps_profile': False, 12:47:17 INFO - 'sps_profile_interval': 0, 12:47:17 INFO - 'suite': 'dromaeojs-e10s', 12:47:17 INFO - 'system_bits': '32', 12:47:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:47:17 INFO - 'title': 'talos-linux64-ix-049', 12:47:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:47:17 INFO - 'use_talos_json': True, 12:47:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:47:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:47:17 INFO - 'work_dir': 'build'} 12:47:17 INFO - [mozharness: 2016-08-29 19:47:17.221584Z] Running clobber step. 12:47:17 INFO - Running pre-action listener: _resource_record_pre_action 12:47:17 INFO - Running main action method: clobber 12:47:17 INFO - rmtree: /builds/slave/test/build 12:47:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:47:17 INFO - Running post-action listener: _resource_record_post_action 12:47:17 INFO - [mozharness: 2016-08-29 19:47:17.682426Z] Finished clobber step (success) 12:47:17 INFO - [mozharness: 2016-08-29 19:47:17.682529Z] Running read-buildbot-config step. 12:47:17 INFO - Running pre-action listener: _resource_record_pre_action 12:47:17 INFO - Running main action method: read_buildbot_config 12:47:17 INFO - Using buildbot properties: 12:47:17 INFO - { 12:47:17 INFO - "project": "", 12:47:17 INFO - "product": "firefox", 12:47:17 INFO - "script_repo_revision": "production", 12:47:17 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 12:47:17 INFO - "repository": "", 12:47:17 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 12:47:17 INFO - "buildid": "20160829115230", 12:47:17 INFO - "pgo_build": "False", 12:47:17 INFO - "basedir": "/builds/slave/test", 12:47:17 INFO - "buildnumber": 353, 12:47:17 INFO - "slavename": "talos-linux64-ix-049", 12:47:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:47:17 INFO - "platform": "ubuntu64_hw", 12:47:17 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 12:47:17 INFO - "branch": "autoland", 12:47:17 INFO - "repo_path": "integration/autoland", 12:47:17 INFO - "revision": "fa10bd34b8f7cbfbe275c6ebe9a33b583e179b3a", 12:47:17 INFO - "stage_platform": "linux64", 12:47:17 INFO - "builduid": "e6942d70d2144a79951f9c306fbd7350", 12:47:17 INFO - "slavebuilddir": "test" 12:47:17 INFO - } 12:47:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:47:17 INFO - Running post-action listener: _resource_record_post_action 12:47:17 INFO - [mozharness: 2016-08-29 19:47:17.684977Z] Finished read-buildbot-config step (success) 12:47:17 INFO - [mozharness: 2016-08-29 19:47:17.685067Z] Running download-and-extract step. 12:47:17 INFO - Running pre-action listener: _resource_record_pre_action 12:47:17 INFO - Running main action method: download_and_extract 12:47:17 INFO - mkdir: /builds/slave/test/build/tests 12:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:17 INFO - trying https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:47:17 INFO - Downloading https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:47:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:47:18 INFO - Downloaded 1361 bytes. 12:47:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:47:18 INFO - Using the following test package requirements: 12:47:18 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:47:18 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:47:18 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:47:18 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:18 INFO - u'jsshell-linux-x86_64.zip'], 12:47:18 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:47:18 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:47:18 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:47:18 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:47:18 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:47:18 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:47:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:18 INFO - trying https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:47:18 INFO - Downloading https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:47:19 INFO - Downloaded 20308050 bytes. 12:47:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 12:47:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:23 INFO - trying https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:47:23 INFO - Downloading https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:47:24 INFO - Downloaded 20308050 bytes. 12:47:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 12:47:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:28 INFO - trying https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:47:28 INFO - Downloading https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:47:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:47:29 INFO - Downloaded 14413998 bytes. 12:47:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 12:47:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:29 INFO - trying https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:47:29 INFO - Downloading https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:47:30 INFO - Downloaded 55872118 bytes. 12:47:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:47:30 INFO - mkdir: /builds/slave/test/properties 12:47:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:47:30 INFO - Writing to file /builds/slave/test/properties/build_url 12:47:30 INFO - Contents: 12:47:30 INFO - build_url:https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:47:31 INFO - Running post-action listener: _resource_record_post_action 12:47:31 INFO - Running post-action listener: set_extra_try_arguments 12:47:31 INFO - [mozharness: 2016-08-29 19:47:31.562811Z] Finished download-and-extract step (success) 12:47:31 INFO - [mozharness: 2016-08-29 19:47:31.563043Z] Running populate-webroot step. 12:47:31 INFO - Running pre-action listener: _resource_record_pre_action 12:47:31 INFO - Running main action method: populate_webroot 12:47:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:47:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:47:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:47:31 INFO - '--tppagecycles', 12:47:31 INFO - '7'], 12:47:31 INFO - 'tests': ['tsvgm']}}, 12:47:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:47:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:47:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:47:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:47:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:31 INFO - 'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:31 INFO - 'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['damp', 'tps']}, 12:47:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:31 INFO - 'tests': ['damp', 'tps']}, 12:47:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['dromaeo_dom']}, 12:47:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:47:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['basic_compositor_video']}, 12:47:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:47:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['a11yr', 12:47:31 INFO - 'ts_paint', 12:47:31 INFO - 'tpaint', 12:47:31 INFO - 'sessionrestore', 12:47:31 INFO - 'sessionrestore_no_auto_restore', 12:47:31 INFO - 'tabpaint']}, 12:47:31 INFO - 'other-e10s': {'tests': ['a11yr', 12:47:31 INFO - 'ts_paint', 12:47:31 INFO - 'tpaint', 12:47:31 INFO - 'sessionrestore', 12:47:31 INFO - 'sessionrestore_no_auto_restore', 12:47:31 INFO - 'tabpaint']}, 12:47:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:47:31 INFO - 'ts_paint', 12:47:31 INFO - 'tpaint', 12:47:31 INFO - 'sessionrestore', 12:47:31 INFO - 'sessionrestore_no_auto_restore', 12:47:31 INFO - 'tabpaint']}, 12:47:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:47:31 INFO - 'ts_paint', 12:47:31 INFO - 'tpaint', 12:47:31 INFO - 'sessionrestore', 12:47:31 INFO - 'sessionrestore_no_auto_restore', 12:47:31 INFO - 'tabpaint']}, 12:47:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['a11yr', 12:47:31 INFO - 'ts_paint', 12:47:31 INFO - 'tpaint', 12:47:31 INFO - 'sessionrestore', 12:47:31 INFO - 'sessionrestore_no_auto_restore', 12:47:31 INFO - 'tabpaint']}, 12:47:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['a11yr', 12:47:31 INFO - 'ts_paint', 12:47:31 INFO - 'tpaint', 12:47:31 INFO - 'sessionrestore', 12:47:31 INFO - 'sessionrestore_no_auto_restore', 12:47:31 INFO - 'tabpaint']}, 12:47:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['tsvgx', 12:47:31 INFO - 'tsvgr_opacity', 12:47:31 INFO - 'tart', 12:47:31 INFO - 'tscrollx', 12:47:31 INFO - 'cart']}, 12:47:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:47:31 INFO - 'tsvgr_opacity', 12:47:31 INFO - 'tart', 12:47:31 INFO - 'tscrollx', 12:47:31 INFO - 'cart']}, 12:47:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:31 INFO - 'talos_options': ['--disable-e10s'], 12:47:31 INFO - 'tests': ['tp5o']}, 12:47:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:31 INFO - 'tests': ['tp5o']}, 12:47:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:31 INFO - 'talos_options': ['--disable-e10s', 12:47:31 INFO - '--xperf_path', 12:47:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:31 INFO - 'tests': ['tp5n']}, 12:47:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:31 INFO - 'talos_options': ['--xperf_path', 12:47:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:31 INFO - 'tests': ['tp5n']}}, 12:47:31 INFO - 'talos.zip': {'path': '', 12:47:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:47:31 INFO - Running post-action listener: _resource_record_post_action 12:47:31 INFO - [mozharness: 2016-08-29 19:47:31.582283Z] Finished populate-webroot step (success) 12:47:31 INFO - [mozharness: 2016-08-29 19:47:31.582373Z] Running create-virtualenv step. 12:47:31 INFO - Running pre-action listener: _resource_record_pre_action 12:47:31 INFO - Running main action method: create_virtualenv 12:47:31 INFO - Creating virtualenv /builds/slave/test/build/venv 12:47:31 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:47:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:47:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:47:31 INFO - Using real prefix '/usr' 12:47:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:47:32 INFO - Installing distribute.............................................................................................................................................................................................done. 12:47:34 INFO - Installing pip.................done. 12:47:34 INFO - Return code: 0 12:47:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:47:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:34 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 0x7f5da39d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', '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:47:34 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:47:34 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:47:34 INFO - Using env: {'DISPLAY': ':0', 12:47:34 INFO - 'HOME': '/home/cltbld', 12:47:34 INFO - 'LANG': 'en_US.UTF-8', 12:47:34 INFO - 'LANGUAGE': 'en_US:en', 12:47:34 INFO - 'LOGNAME': 'cltbld', 12:47:34 INFO - 'MAIL': '/var/mail/cltbld', 12:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:34 INFO - 'MOZ_NO_REMOTE': '1', 12:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:34 INFO - 'NO_EM_RESTART': '1', 12:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:34 INFO - 'PWD': '/builds/slave/test', 12:47:34 INFO - 'SHELL': '/bin/bash', 12:47:34 INFO - 'SHLVL': '1', 12:47:34 INFO - 'TERM': 'linux', 12:47:34 INFO - 'TMOUT': '86400', 12:47:34 INFO - 'USER': 'cltbld', 12:47:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:34 INFO - '_': '/tools/buildbot/bin/python'} 12:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:34 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:47:34 INFO - Cleaning up... 12:47:34 INFO - Return code: 0 12:47:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:47:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:34 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 0x7f5da39d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', '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:47:34 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:47:34 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:47:34 INFO - Using env: {'DISPLAY': ':0', 12:47:34 INFO - 'HOME': '/home/cltbld', 12:47:34 INFO - 'LANG': 'en_US.UTF-8', 12:47:34 INFO - 'LANGUAGE': 'en_US:en', 12:47:34 INFO - 'LOGNAME': 'cltbld', 12:47:34 INFO - 'MAIL': '/var/mail/cltbld', 12:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:34 INFO - 'MOZ_NO_REMOTE': '1', 12:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:34 INFO - 'NO_EM_RESTART': '1', 12:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:34 INFO - 'PWD': '/builds/slave/test', 12:47:34 INFO - 'SHELL': '/bin/bash', 12:47:34 INFO - 'SHLVL': '1', 12:47:34 INFO - 'TERM': 'linux', 12:47:34 INFO - 'TMOUT': '86400', 12:47:34 INFO - 'USER': 'cltbld', 12:47:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:34 INFO - '_': '/tools/buildbot/bin/python'} 12:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:34 INFO - Downloading/unpacking psutil>=3.1.1 12:47:34 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:47:34 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:47:34 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:47:34 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:47:34 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:47:34 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:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:47:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:36 INFO - Installing collected packages: psutil 12:47:36 INFO - Running setup.py install for psutil 12:47:36 INFO - building 'psutil._psutil_linux' extension 12:47:36 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:47:36 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:47:36 INFO - building 'psutil._psutil_posix' extension 12:47:36 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:47:36 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:47:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:37 INFO - Successfully installed psutil 12:47:37 INFO - Cleaning up... 12:47:37 INFO - Return code: 0 12:47:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:37 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 0x7f5da39d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', '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:47:37 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:47:37 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:47:37 INFO - Using env: {'DISPLAY': ':0', 12:47:37 INFO - 'HOME': '/home/cltbld', 12:47:37 INFO - 'LANG': 'en_US.UTF-8', 12:47:37 INFO - 'LANGUAGE': 'en_US:en', 12:47:37 INFO - 'LOGNAME': 'cltbld', 12:47:37 INFO - 'MAIL': '/var/mail/cltbld', 12:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:37 INFO - 'MOZ_NO_REMOTE': '1', 12:47:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:37 INFO - 'NO_EM_RESTART': '1', 12:47:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:37 INFO - 'PWD': '/builds/slave/test', 12:47:37 INFO - 'SHELL': '/bin/bash', 12:47:37 INFO - 'SHLVL': '1', 12:47:37 INFO - 'TERM': 'linux', 12:47:37 INFO - 'TMOUT': '86400', 12:47:37 INFO - 'USER': 'cltbld', 12:47:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:37 INFO - '_': '/tools/buildbot/bin/python'} 12:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:47:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:47:39 INFO - Installing collected packages: mozsystemmonitor 12:47:39 INFO - Running setup.py install for mozsystemmonitor 12:47:39 INFO - Successfully installed mozsystemmonitor 12:47:39 INFO - Cleaning up... 12:47:39 INFO - Return code: 0 12:47:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:39 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 0x7f5da39d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', '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:47:39 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:47:39 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:47:39 INFO - Using env: {'DISPLAY': ':0', 12:47:39 INFO - 'HOME': '/home/cltbld', 12:47:39 INFO - 'LANG': 'en_US.UTF-8', 12:47:39 INFO - 'LANGUAGE': 'en_US:en', 12:47:39 INFO - 'LOGNAME': 'cltbld', 12:47:39 INFO - 'MAIL': '/var/mail/cltbld', 12:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:39 INFO - 'MOZ_NO_REMOTE': '1', 12:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:39 INFO - 'NO_EM_RESTART': '1', 12:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:39 INFO - 'PWD': '/builds/slave/test', 12:47:39 INFO - 'SHELL': '/bin/bash', 12:47:39 INFO - 'SHLVL': '1', 12:47:39 INFO - 'TERM': 'linux', 12:47:39 INFO - 'TMOUT': '86400', 12:47:39 INFO - 'USER': 'cltbld', 12:47:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:39 INFO - '_': '/tools/buildbot/bin/python'} 12:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:39 INFO - Downloading/unpacking jsonschema==2.5.1 12:47:39 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:47:39 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:47:39 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:47:39 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:47:39 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:47:39 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:47:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:47:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:47:42 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:47:42 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:47:42 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:47:42 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:47:42 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:47:42 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:47:42 INFO - Downloading functools32-3.2.3-2.tar.gz 12:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:47:42 INFO - warning: no files found matching '*.txt' 12:47:42 INFO - no previously-included directories found matching 'build' 12:47:42 INFO - no previously-included directories found matching 'dist' 12:47:42 INFO - no previously-included directories found matching '.git*' 12:47:42 INFO - Installing collected packages: jsonschema, functools32 12:47:42 INFO - Running setup.py install for functools32 12:47:42 INFO - warning: no files found matching '*.txt' 12:47:42 INFO - no previously-included directories found matching 'build' 12:47:42 INFO - no previously-included directories found matching 'dist' 12:47:42 INFO - no previously-included directories found matching '.git*' 12:47:42 INFO - Successfully installed jsonschema functools32 12:47:42 INFO - Cleaning up... 12:47:43 INFO - Return code: 0 12:47:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:47:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:43 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5da39d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', '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:47:43 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:47:43 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 functools32==3.2.3-2 12:47:43 INFO - Using env: {'DISPLAY': ':0', 12:47:43 INFO - 'HOME': '/home/cltbld', 12:47:43 INFO - 'LANG': 'en_US.UTF-8', 12:47:43 INFO - 'LANGUAGE': 'en_US:en', 12:47:43 INFO - 'LOGNAME': 'cltbld', 12:47:43 INFO - 'MAIL': '/var/mail/cltbld', 12:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:43 INFO - 'MOZ_NO_REMOTE': '1', 12:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:43 INFO - 'NO_EM_RESTART': '1', 12:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:43 INFO - 'PWD': '/builds/slave/test', 12:47:43 INFO - 'SHELL': '/bin/bash', 12:47:43 INFO - 'SHLVL': '1', 12:47:43 INFO - 'TERM': 'linux', 12:47:43 INFO - 'TMOUT': '86400', 12:47:43 INFO - 'USER': 'cltbld', 12:47:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:43 INFO - '_': '/tools/buildbot/bin/python'} 12:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:47:43 INFO - Cleaning up... 12:47:43 INFO - Return code: 0 12:47:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:47:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:43 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 0x7f5da39d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', '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:47:43 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:47:43 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:47:43 INFO - Using env: {'DISPLAY': ':0', 12:47:43 INFO - 'HOME': '/home/cltbld', 12:47:43 INFO - 'LANG': 'en_US.UTF-8', 12:47:43 INFO - 'LANGUAGE': 'en_US:en', 12:47:43 INFO - 'LOGNAME': 'cltbld', 12:47:43 INFO - 'MAIL': '/var/mail/cltbld', 12:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:43 INFO - 'MOZ_NO_REMOTE': '1', 12:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:43 INFO - 'NO_EM_RESTART': '1', 12:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:43 INFO - 'PWD': '/builds/slave/test', 12:47:43 INFO - 'SHELL': '/bin/bash', 12:47:43 INFO - 'SHLVL': '1', 12:47:43 INFO - 'TERM': 'linux', 12:47:43 INFO - 'TMOUT': '86400', 12:47:43 INFO - 'USER': 'cltbld', 12:47:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:43 INFO - '_': '/tools/buildbot/bin/python'} 12:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:43 INFO - Downloading/unpacking blobuploader==1.2.4 12:47:43 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:47:43 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:47:43 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:47:43 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:47:43 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:47:43 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:47:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:47:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:47:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:46 INFO - Downloading docopt-0.6.1.tar.gz 12:47:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:47:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:47:46 INFO - Running setup.py install for blobuploader 12:47:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:47:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:47:46 INFO - Running setup.py install for requests 12:47:46 INFO - Running setup.py install for docopt 12:47:46 INFO - Successfully installed blobuploader requests docopt 12:47:46 INFO - Cleaning up... 12:47:46 INFO - Return code: 0 12:47:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:46 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 0x7f5da39d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', '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:47:46 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:47:46 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:47:46 INFO - Using env: {'DISPLAY': ':0', 12:47:46 INFO - 'HOME': '/home/cltbld', 12:47:46 INFO - 'LANG': 'en_US.UTF-8', 12:47:46 INFO - 'LANGUAGE': 'en_US:en', 12:47:46 INFO - 'LOGNAME': 'cltbld', 12:47:46 INFO - 'MAIL': '/var/mail/cltbld', 12:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:46 INFO - 'MOZ_NO_REMOTE': '1', 12:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:46 INFO - 'NO_EM_RESTART': '1', 12:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:46 INFO - 'PWD': '/builds/slave/test', 12:47:46 INFO - 'SHELL': '/bin/bash', 12:47:46 INFO - 'SHLVL': '1', 12:47:46 INFO - 'TERM': 'linux', 12:47:46 INFO - 'TMOUT': '86400', 12:47:46 INFO - 'USER': 'cltbld', 12:47:46 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:46 INFO - '_': '/tools/buildbot/bin/python'} 12:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:46 INFO - Running setup.py (path:/tmp/pip-XJ9IEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:46 INFO - Running setup.py (path:/tmp/pip-edCCCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:47 INFO - Running setup.py (path:/tmp/pip-r9WVKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:47 INFO - Running setup.py (path:/tmp/pip-vUINTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:47 INFO - Running setup.py (path:/tmp/pip-vcEeK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:47 INFO - Running setup.py (path:/tmp/pip-WUcsGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:47 INFO - Running setup.py (path:/tmp/pip-GeFOmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:47 INFO - Running setup.py (path:/tmp/pip-zRBbsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:47 INFO - Running setup.py (path:/tmp/pip-y45JAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:47 INFO - Running setup.py (path:/tmp/pip-coHL8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:47 INFO - Running setup.py (path:/tmp/pip-9j32hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:47 INFO - Running setup.py (path:/tmp/pip-klPxAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:47 INFO - Running setup.py (path:/tmp/pip-EdEadi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:47 INFO - Running setup.py (path:/tmp/pip-kUkeDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:47 INFO - Running setup.py (path:/tmp/pip-iqeGF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:47 INFO - Running setup.py (path:/tmp/pip-wqgi32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:48 INFO - Running setup.py (path:/tmp/pip-2zWEak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:47:48 INFO - Running setup.py install for manifestparser 12:47:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:47:48 INFO - Running setup.py install for mozcrash 12:47:48 INFO - Running setup.py install for mozdebug 12:47:48 INFO - Running setup.py install for mozdevice 12:47:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:47:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:47:48 INFO - Running setup.py install for mozfile 12:47:48 INFO - Running setup.py install for mozhttpd 12:47:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:47:48 INFO - Running setup.py install for mozinfo 12:47:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:47:48 INFO - Running setup.py install for mozInstall 12:47:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:47:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:47:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:47:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:47:48 INFO - Running setup.py install for mozleak 12:47:49 INFO - Running setup.py install for mozlog 12:47:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:47:49 INFO - Running setup.py install for moznetwork 12:47:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:47:49 INFO - Running setup.py install for mozprocess 12:47:49 INFO - Running setup.py install for mozprofile 12:47:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:47:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:47:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:47:49 INFO - Running setup.py install for mozrunner 12:47:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:47:49 INFO - Running setup.py install for mozscreenshot 12:47:49 INFO - Running setup.py install for moztest 12:47:49 INFO - Running setup.py install for mozversion 12:47:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:47:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:47:49 INFO - Cleaning up... 12:47:49 INFO - Return code: 0 12:47:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:49 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:49 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:49 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 0x7f5da39d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', '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:47:49 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:47:49 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:47:49 INFO - Using env: {'DISPLAY': ':0', 12:47:49 INFO - 'HOME': '/home/cltbld', 12:47:49 INFO - 'LANG': 'en_US.UTF-8', 12:47:49 INFO - 'LANGUAGE': 'en_US:en', 12:47:49 INFO - 'LOGNAME': 'cltbld', 12:47:49 INFO - 'MAIL': '/var/mail/cltbld', 12:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:49 INFO - 'MOZ_NO_REMOTE': '1', 12:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:49 INFO - 'NO_EM_RESTART': '1', 12:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:49 INFO - 'PWD': '/builds/slave/test', 12:47:49 INFO - 'SHELL': '/bin/bash', 12:47:49 INFO - 'SHLVL': '1', 12:47:49 INFO - 'TERM': 'linux', 12:47:49 INFO - 'TMOUT': '86400', 12:47:49 INFO - 'USER': 'cltbld', 12:47:49 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:49 INFO - '_': '/tools/buildbot/bin/python'} 12:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:50 INFO - Running setup.py (path:/tmp/pip-sr6qmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:50 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:50 INFO - Running setup.py (path:/tmp/pip-RxF0dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:50 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:50 INFO - Running setup.py (path:/tmp/pip-2UVLLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:50 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:50 INFO - Running setup.py (path:/tmp/pip-irYQx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:50 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:50 INFO - Running setup.py (path:/tmp/pip-bHjrkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:50 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:50 INFO - Running setup.py (path:/tmp/pip-u6Drk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:50 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:50 INFO - Running setup.py (path:/tmp/pip-NPtpxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:50 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:50 INFO - Running setup.py (path:/tmp/pip-1ithiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:50 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:50 INFO - Running setup.py (path:/tmp/pip-aoF0TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:50 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:50 INFO - Running setup.py (path:/tmp/pip-HRSdv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:50 INFO - Running setup.py (path:/tmp/pip-2gyFPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:50 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:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:50 INFO - Running setup.py (path:/tmp/pip-QbSxO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:51 INFO - Running setup.py (path:/tmp/pip-CfagHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:51 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:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:51 INFO - Running setup.py (path:/tmp/pip-7CVp6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:51 INFO - Running setup.py (path:/tmp/pip-zIMIn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:51 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:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:51 INFO - Running setup.py (path:/tmp/pip-bjWYlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:51 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:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:51 INFO - Running setup.py (path:/tmp/pip-pBbpUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:51 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:47:51 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:47:51 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:47:51 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:47:51 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:47:51 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:47:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:53 INFO - Downloading blessings-1.6.tar.gz 12:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:47:53 INFO - Installing collected packages: blessings 12:47:53 INFO - Running setup.py install for blessings 12:47:53 INFO - Successfully installed blessings 12:47:53 INFO - Cleaning up... 12:47:53 INFO - Return code: 0 12:47:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:47:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:47:53 INFO - Reading from file tmpfile_stdout 12:47:53 INFO - Current package versions: 12:47:53 INFO - argparse == 1.2.1 12:47:53 INFO - blessings == 1.6 12:47:53 INFO - blobuploader == 1.2.4 12:47:53 INFO - docopt == 0.6.1 12:47:53 INFO - functools32 == 3.2.3-2 12:47:53 INFO - jsonschema == 2.5.1 12:47:53 INFO - manifestparser == 1.1 12:47:53 INFO - mozInstall == 1.12 12:47:53 INFO - mozcrash == 0.17 12:47:53 INFO - mozdebug == 0.1 12:47:53 INFO - mozdevice == 0.48 12:47:53 INFO - mozfile == 1.2 12:47:53 INFO - mozhttpd == 0.7 12:47:53 INFO - mozinfo == 0.9 12:47:53 INFO - mozleak == 0.1 12:47:53 INFO - mozlog == 3.3 12:47:53 INFO - moznetwork == 0.27 12:47:53 INFO - mozprocess == 0.23 12:47:53 INFO - mozprofile == 0.28 12:47:53 INFO - mozrunner == 6.12 12:47:53 INFO - mozscreenshot == 0.1 12:47:53 INFO - mozsystemmonitor == 0.3 12:47:53 INFO - moztest == 0.7 12:47:53 INFO - mozversion == 1.4 12:47:53 INFO - psutil == 3.1.1 12:47:53 INFO - requests == 1.2.3 12:47:53 INFO - wsgiref == 0.1.2 12:47:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:53 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 0x7f5da39d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', '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:47:53 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:47:53 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:47:53 INFO - Using env: {'DISPLAY': ':0', 12:47:53 INFO - 'HOME': '/home/cltbld', 12:47:53 INFO - 'LANG': 'en_US.UTF-8', 12:47:53 INFO - 'LANGUAGE': 'en_US:en', 12:47:53 INFO - 'LOGNAME': 'cltbld', 12:47:53 INFO - 'MAIL': '/var/mail/cltbld', 12:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:53 INFO - 'MOZ_NO_REMOTE': '1', 12:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:53 INFO - 'NO_EM_RESTART': '1', 12:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:53 INFO - 'PWD': '/builds/slave/test', 12:47:53 INFO - 'SHELL': '/bin/bash', 12:47:53 INFO - 'SHLVL': '1', 12:47:53 INFO - 'TERM': 'linux', 12:47:53 INFO - 'TMOUT': '86400', 12:47:53 INFO - 'USER': 'cltbld', 12:47:53 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:53 INFO - '_': '/tools/buildbot/bin/python'} 12:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 INFO - Cleaning up... 12:47:53 INFO - Return code: 0 12:47:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:47:54 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:54 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:54 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 0x7f5da39d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', '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:47:54 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:47:54 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:47:54 INFO - Using env: {'DISPLAY': ':0', 12:47:54 INFO - 'HOME': '/home/cltbld', 12:47:54 INFO - 'LANG': 'en_US.UTF-8', 12:47:54 INFO - 'LANGUAGE': 'en_US:en', 12:47:54 INFO - 'LOGNAME': 'cltbld', 12:47:54 INFO - 'MAIL': '/var/mail/cltbld', 12:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:54 INFO - 'MOZ_NO_REMOTE': '1', 12:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:54 INFO - 'NO_EM_RESTART': '1', 12:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:54 INFO - 'PWD': '/builds/slave/test', 12:47:54 INFO - 'SHELL': '/bin/bash', 12:47:54 INFO - 'SHLVL': '1', 12:47:54 INFO - 'TERM': 'linux', 12:47:54 INFO - 'TMOUT': '86400', 12:47:54 INFO - 'USER': 'cltbld', 12:47:54 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:54 INFO - '_': '/tools/buildbot/bin/python'} 12:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:47:54 INFO - Cleaning up... 12:47:54 INFO - Return code: 0 12:47:54 INFO - Running post-action listener: _resource_record_post_action 12:47:54 INFO - Running post-action listener: _start_resource_monitoring 12:47:54 INFO - Starting resource monitoring. 12:47:54 INFO - [mozharness: 2016-08-29 19:47:54.254412Z] Finished create-virtualenv step (success) 12:47:54 INFO - [mozharness: 2016-08-29 19:47:54.254928Z] Running install step. 12:47:54 INFO - Running pre-action listener: _resource_record_pre_action 12:47:54 INFO - Running main action method: install 12:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:47:54 INFO - Reading from file tmpfile_stdout 12:47:54 INFO - Detecting whether we're running mozinstall >=1.0... 12:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:47:54 INFO - Reading from file tmpfile_stdout 12:47:54 INFO - Output received: 12:47:54 INFO - Usage: mozinstall [options] installer 12:47:54 INFO - Options: 12:47:54 INFO - -h, --help show this help message and exit 12:47:54 INFO - -d DEST, --destination=DEST 12:47:54 INFO - Directory to install application into. [default: 12:47:54 INFO - "/builds/slave/test"] 12:47:54 INFO - --app=APP Application being installed. [default: firefox] 12:47:54 INFO - mkdir: /builds/slave/test/build/application 12:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:48:10 INFO - Reading from file tmpfile_stdout 12:48:10 INFO - Output received: 12:48:10 INFO - /builds/slave/test/build/application/firefox/firefox 12:48:10 INFO - Running post-action listener: _resource_record_post_action 12:48:10 INFO - [mozharness: 2016-08-29 19:48:10.689378Z] Finished install step (success) 12:48:10 INFO - [mozharness: 2016-08-29 19:48:10.689660Z] Running run-tests step. 12:48:10 INFO - Running pre-action listener: _resource_record_pre_action 12:48:10 INFO - Running main action method: run_tests 12:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:48:10 INFO - Python 2.7.3 12:48:10 INFO - Return code: 0 12:48:10 INFO - grabbing minidump binary from tooltool 12:48:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:10 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 0x2ac3090>, '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 0x2ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:48:10 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:48:10 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:48:10 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:48:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:48:10 INFO - Return code: 0 12:48:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:48:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:48:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:48:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:48:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:48:10 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/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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:48:10 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/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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:48:10 INFO - Using env: {'DISPLAY': ':0', 12:48:10 INFO - 'HOME': '/home/cltbld', 12:48:10 INFO - 'LANG': 'en_US.UTF-8', 12:48:10 INFO - 'LANGUAGE': 'en_US:en', 12:48:10 INFO - 'LOGNAME': 'cltbld', 12:48:10 INFO - 'MAIL': '/var/mail/cltbld', 12:48:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:48:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:10 INFO - 'MOZ_NO_REMOTE': '1', 12:48:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:10 INFO - 'NO_EM_RESTART': '1', 12:48:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:10 INFO - 'PWD': '/builds/slave/test', 12:48:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:48:10 INFO - 'SHELL': '/bin/bash', 12:48:10 INFO - 'SHLVL': '1', 12:48:10 INFO - 'TERM': 'linux', 12:48:10 INFO - 'TMOUT': '86400', 12:48:10 INFO - 'USER': 'cltbld', 12:48:10 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517', 12:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:10 INFO - '_': '/tools/buildbot/bin/python'} 12:48:10 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/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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:48:10 INFO - mozversion application_buildid: 20160829115230 12:48:10 INFO - mozversion application_changeset: fa10bd34b8f7cbfbe275c6ebe9a33b583e179b3a 12:48:10 INFO - mozversion application_display_name: Nightly 12:48:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:48:10 INFO - mozversion application_name: Firefox 12:48:10 INFO - mozversion application_remotingname: firefox 12:48:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:48:10 INFO - mozversion application_vendor: Mozilla 12:48:10 INFO - mozversion application_version: 51.0a1 12:48:10 INFO - mozversion platform_buildid: 20160829115230 12:48:10 INFO - mozversion platform_changeset: fa10bd34b8f7cbfbe275c6ebe9a33b583e179b3a 12:48:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:48:10 INFO - mozversion platform_version: 51.0a1 12:48:10 INFO - using testdate: 1472500090 12:48:10 INFO - actual date: 1472500090 12:48:10 INFO - starting webserver on 'localhost:52978' 12:48:10 INFO - SUITE-START | Running 2 tests 12:48:10 INFO - TEST-START | dromaeo_css 12:48:10 INFO - operating with platform_type : linux_ 12:48:10 INFO - Initialising browser for dromaeo_css test... 12:48:10 INFO - TEST-INFO | started process 23996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9SDKzK/profile http://localhost:52978/getInfo.html) 12:48:16 INFO - PROCESS | 23996 | __metrics Screen width/height:1600/1200 12:48:16 INFO - PROCESS | 23996 | colorDepth:24 12:48:16 INFO - PROCESS | 23996 | Browser inner width/height: 1024/697 12:48:16 INFO - PROCESS | 23996 | __metrics 12:48:16 ERROR - PROCESS | 23996 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 12:48:17 INFO - TEST-INFO | 23996: exit 0 12:48:17 INFO - Browser initialized. 12:48:17 INFO - Running cycle 1/1 for dromaeo_css test... 12:48:17 INFO - TEST-INFO | started process 24116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9SDKzK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:48:29 INFO - PROCESS | 24116 | RSS: Main: 192413696 12:48:29 INFO - PROCESS | 24116 | 12:49:19 INFO - PROCESS | 24116 | 1472500159528 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:51:32 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:52978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52978/tests/dromaeo/cssquery-ext.html) 12:51:33 INFO - PROCESS | 24116 | RSS: Main: 212459520 12:51:33 INFO - PROCESS | 24116 | 12:54:35 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:52978/tests/dromaeo/cssquery-ext.html (next: http://localhost:52978/tests/dromaeo/cssquery-jquery.html) 12:54:36 INFO - PROCESS | 24116 | RSS: Main: 206991360 12:54:36 INFO - PROCESS | 24116 | 12:57:38 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:52978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52978/tests/dromaeo/cssquery-mootools.html) 12:57:39 INFO - PROCESS | 24116 | RSS: Main: 200650752 12:57:39 INFO - PROCESS | 24116 | 13:00:41 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:52978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52978/tests/dromaeo/cssquery-prototype.html) 13:00:41 INFO - PROCESS | 24116 | RSS: Main: 194318336 13:00:41 INFO - PROCESS | 24116 | 13:03:44 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:52978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52978/tests/dromaeo/cssquery-yui.html) 13:03:45 INFO - PROCESS | 24116 | RSS: Main: 197648384 13:03:45 INFO - PROCESS | 24116 | 13:06:48 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:52978/tests/dromaeo/cssquery-yui.html (next: http://localhost:52978/tests/dromaeo/cssquery-dojo.html) 13:06:48 INFO - PROCESS | 24116 | RSS: Main: 198160384 13:06:48 INFO - PROCESS | 24116 | 13:06:48 INFO - PROCESS | 24116 | __start_tp_report 13:06:48 INFO - PROCESS | 24116 | _x_x_mozilla_page_load 13:06:48 INFO - PROCESS | 24116 | _x_x_mozilla_page_load_details 13:06:48 INFO - PROCESS | 24116 | |i|pagename|runs| 13:06:48 INFO - PROCESS | 24116 | |0;dojo.html;2592.44262483566;2606.087869245763;2613.6732908386452;2647.536681080811;2648.4835457085874;4690.671652984292;4777.092352453036;4789.904201915964;4806.423229212491;4863.708177509352;4744.833930812422;4795.040991801645;4801.063792560452;4856.7571621418965;4893.2170852663585;4373.300271956487;4403.031333106712;4448.733076015434;4560.931586026196;4562.885927851797;4459.843905463309;4505.8422955196575;4533.818647254106;4548.931766023512;4553.248713962193;4298.46269216348;4375.868723938287;4379.715318504287;4404.031113155101;4418.8453404130705;4428.4243048403505;4429.844955426544;4481.058977614704;4487.551244875519;4489.416375871148;4367.213901497729;4369.082492676542;4392.450943632046;4393.934090988638;4432.734035957853;4708.952910470885;4754.66717329787;4779.426468823764;4810.494898035691;4828.420589529243;5180.585553155738;5182.144946083891;5193.766280517348;5205.219217117425;5233.241180028875;5214.556762675177;5216.739163041871;5219.582433405357;5224.63427560071;5292.973535132338;4711.599514041345;4784.354112194878;4824.155772739791;4828.058528586892;4834.564889159922;5319.840404787863;5320.654157479751;5328.653637513627;5381.730913454312;5394.190871369326;5078.415982162025;5084.389873215164;5084.720340381241;5090;5145.974270128625;5026.170681837529;5108.131617624938;5181.5854731621375;5184.300119483897;5190.740462976836;5078.085944529947;5094.643374963791;5134.691918484903;5134.897302053938;5140.974295128501;5112.105381558213;5116.304548102932;5120.948790512047;5123.8719032023755;5185.144451165515;4235.555266697014;4257.148570285955;4270.978645106817;4354.172707185625;4365.519792822787;3775.414810704345;3787.791671458041;3836.290286296988;3844.557875844258;3860.1314704191896;4345.587169218919;4477.552244775497;4478.932816007762;4487.147441986078;4531.093781243764;5050.823221187241;5126.282320475137;5131.307273518028;5194.480551944851;5273.472652734773;4431.645468362523;4447.288433850633;4484.551544845554;4485.865424037284;4490.640748740158;4634.374359461497;4644.233701439292;4645.442546894395;4657.580817726353;4674.766261686902;4738.857834264978;4771.23660214364;4795;4841.249606310957;4848.854534363974;5159.845204643867;5185.09260879337;5186.377634683862;5226.425093239664;5248.1340578804065;4809.182438985311;4811.302361157683;4813.4945830688675;4822.71063736177;4879.804807807648;4979.203327467588;5018.573421259088;5080.695158290367;5081.695098294114;5098.260752190838;5140.897182056263;5158.819441319536;5173.715445650525;5181;5228.6078544110105;5024.748762561784;5026.798928042837;5027.396712394536;5040.218766091261;5090.261912022662;4760.833370832004;4916.532929371704;4937.160682683881;5001.174806156943;5009.699418034929;4904.509549045067;4917.311576379238;4970.478099799614;5059.5952323814745;5065.417476990193;5106.540411362995;5107.387113546398;5107.719075450886;5108.412532558655;5158.767855446439;4950.925736113889;4975.626827987843;4978.950210497848;4990.3762029746285;5008.198688210015 13:06:48 INFO - PROCESS | 24116 | |1;ext.html;534.599050711966;547.9561435465439;559.0719405786396;560.327606871754;590.4803772680041;33046.50430243545;38012.80993595028;38017.429738553874;38037.23925521488;38208.61791382085;37511.62488375115;37890.62109378906;37997.43003854944;38044.429333560016;38061.429078563844;7554.131274903374;7722.768316950501;7725.61371931404;7728.690852365927;7729.995100636909;7217.566945983232;7619.314261716444;7648.732294369698;7650.273224043734;7651.120121186079;7641.54150750954;7669.884951725729;7685.423593230502;7692.3076923076915;7701.383889288843;7612.885806712876;7635.770926872203;7650.349720273728;7650.54096754191;7661.502002369828;7630.8855367169535;7645.961770191169;7684.077910650702;7684.385249180053;7707.537547747097;30552.08343749691;30683;30895;30895.691043089508;30914.381712365626;3005.6994300569986;3132.342208136294;3429.8971030869116;3467.9653203467897;3483.825808709554;27539.862300688368;27601.723982760115;28325.150245492463;28536.429271414454;29378.853105734335;3374.358871814372;3390.762646614738;3421.161815355229;3434.433318502469;3460.5155278260813;173714;173734;174019;174041.1297943515;174966;44894.77552612216;45003.324950125774;45059.77470112628;45138.54861451409;45280.54719452763;31672.366552668816;32696.182595434828;52522.47477525252;52987.47012529903;52997;14113.647158821112;14629.268536573341;14658.486952956808;14663.56009319722;14704.485343012942;11034.779304413867;11092.55629774816;11102.167337449724;11102.833457498144;11108.389038602792;17297.221625026905;17317.4804755855;17364.739528907077;17508.649827003388;17509.12454377276;6607.2071351438135;6631.204255489276;6720.22717387497;6743.831404214836;6897.7240910363025;782.9060512738508;859.6905114158898;899.7750562359411;913.7350168451208;973.6835528453139;26000.609990850153;27538.449231015267;27652.617369131865;27879.860600696866;28136.71863281382;920.4891285336703;945.385499425379;953.9713808585753;968.5593055159885;1036.9585216591252;14261.21563314007;14508.347124379428;14723;14883.10701357922;14887.553373398816;354100;356486;356522;359773;361349.77300453844;46093.5390646096;46629.766851166205;46652.7667361661;46668;46933.29600056002;1116.7543140509238;1128.644476989762;1133.3992983718642;1140.8916152965455;1162.511745067074;25126.748732512442;25990.220293391227;26654.333641659112;27135.72864271411;27646.5853012209;41647.791761041;42015.159696806506;42025.78987105045;42052;42054.789726051175;293887;295487;295658;296120;297375;24632.630510542716;24882.751172488766;24906.377340566632;25023.499530009663;25063;39796.602033980445;40038.19923601453;40060.7996960025;40435.39346909858;40715;33279.667203327655;33898.49152262669;34263.31473370569;34332.14169645779;34523.65476345205;34687.479687804196;34877.47683784796;35064.29871402609;35107.12232194216;35547.64452355443;27458.119861789586;29865.402691946474;34061;34954.47568286427;35108;28902;31008.53487197739;31090.378192436478;31356.529652055695;31659.52510712295;24162.51674966526;24593.754062459146;24685.62971555392;24857;25233.243002709947 13:06:48 INFO - PROCESS | 24116 | |2;jquery.html;348.5956290702785;355.8203107430747;356.4439474419904;367.97056235501145;374.23469005882964;15760.448384306552;15845.683086338266;16806.49580512585;16898.493045208634;16916.83083169168;14400.27998600071;14845.331960061796;15339.539813805575;15518;15521.844781552209;5015.297858299841;6486.221653401575;6776.2546119926765;6841;6856.485763567727;6710.765123220688;6718.42893354063;6817.727290908382;6833.316668333152;6950.895736563955;6906.205786334561;6942.583444993291;6972.930270697304;6974.232834388238;6978.790636280894;6728.394444500019;6917.89623155653;6997.440204783605;7019.473539484508;7029.82425439363;6541.313162117956;6658.334166583303;6767.763128290536;6774.5257831951785;6780.796576102724;22389.77610223893;23000.539989200122;23567;23572.64641030386;23729;2056.691496275556;2110.398536417129;2239.5423240608734;2328.4295347639936;2445.9388515287083;13947.790783138262;14102.92948535261;14437.494687685881;14914.403423863141;15323.923380383138;1780.9821901781077;1815.4190658989128;1893.1575448925234;1919.0500702152524;1959.6472634925708;80240.59879700623;81041.59479202626;81662;82191;83331.5833420829;15878.364865405254;16307;16506.092164930804;16615.335386584644;16704.248308826132;27502.44995100127;27623.585646215324;27823.443531129265;27927.58108628372;28166.71833281682;8352.916470835335;8486;8502.914970850212;8600.8709869352;8768.210861022411;6799.626020568818;6891.655417229219;7049.08361912948;7077.964610176916;7106.289371062956;7787.610619469117;7970.920290797134;8285.50286982783;8341;8430.367722420842;3065.724084832376;3235.9581992926574;3238.1904523869034;3365.882194123194;3411.812350320756;762.7216066135932;794.8410317936435;813.5281536708695;827.4373426070209;885.5395194498825;16192.352305907632;16780.160991950597;16863.915680421764;17281.308747649953;17510.02329603945;390.785068212482;404.88865561970107;408.2182620282126;763.2596381509926;799.2886331165267;5399.78400863961;5565.443455654402;5665.830025099253;5716.828495145152;5900.911486327708;367711;374535;376285;377536;378081;83520;83799.58100209582;83967.58016209879;86119.56940215384;86791.56604216939;405.98579049733115;422.5352112676093;425.5871804349776;425.64883970723656;427.367496105759;10086.8486972694;10096.19230461576;10252.333598316085;10342.37945723259;10684.305520141166;38651.61348386593;39847.60152398555;39856.402153968294;40042.79978600088;41164.58835411727;54430;54595.72702136464;54648.72675636596;55521.72239138778;55761.721191393786;7577.332986742907;7602.391808655184;7611.124720657195;7835.686572537034;7857.646405911862;8826.02913679482;11343.829842552534;11761.294322340687;11781.116416268986;12054.51781928713;9970.750731231778;10311.535980880728;10419.635312764018;10630.415327157081;10957.780844383227;6566.409023187745;10361.393983932503;10417.583296668048;10448.58205671795;11067.667969960592;10208.489575521342;10385.63650272237;10971.670849874517;11017.237242041236;11052.723681908017;7341.74303899361;7590.658420371207;7715.4599178057;7849.843003140019;8080.191980801873;9983.400995940267;10267.94866025665;10333.638322658671;10388.792224155324;10741.087007604441 13:06:48 INFO - PROCESS | 24116 | |3;mootools.html;1333.8999575031871;1381.930903454827;1453.7165252775712;1615.9111248881306;1691.8815682902193;6805.863882722342;7262.673179706912;7344.706211751523;7907.288344049034;7916.2875341219205;7273.236310187421;7461.738839140631;7461.850762984737;7471.103467583897;7471.514351567144;2144.4638840289927;2171.240065976903;2173.478365192358;2182.203495724057;2183.879886606236;2120.162535798359;2147.6885851551515;2173.1850556041486;2178.5533965537106;2178.9782102179015;2140;2165.0257384177185;2181.269274792938;2182.2689399051337;2193.1994821889975;2119.8092171704466;2129.606022885771;2133.168064454856;2138.9786102138937;2141.1649456711816;2050.487378155461;2100.19142630087;2103.779103194158;2121.2045482943895;2127.5213077057692;7547.358474529671;7660;7722.884156737653;7723.459357844953;7729.497582657109;4363.367311739812;4508.549145085465;4513.480949690795;4526.072155208174;4533.070720502289;2822.604835323036;2869.411770587025;2975.8363290019042;2985.1044686593937;2987.521996480553;890.528020149322;929.3262384771054;953.8330792111353;959.6593209410629;961.0821665309683;10475.423851688154;10496.21278404115;10498.422586757726;10532.104771094466;10542.631007914762;3800.315943130263;3974.701897357652;4098.364753463218;4102.077032667626;4204.579542045833;8892.64429422816;8917.019127895926;8918.10818918103;8949.418287811272;8969.282457403391;4566.97716511422;4570.588647021717;4588.632909367243;4588.816447342069;4591.4260717410325;3668.2663467306647;3948.190620922704;4074.7351422157467;4136.048708796993;4176.14389050244;3564.8930532084078;3623.329684008414;3635.327464419091;3640.8361623726996;3713.9071523212137;1168.5092261250295;1174.5008371442275;1189.5539172810197;1190.3096204201543;1193.2601786892183;775.6625867747548;777.8327659553111;790.6639678136769;807.9636416361278;813.829095889858;4761.571458568746;4799.208130658402;4863.197572400514;4907.263910413467;5049.31834202378;382.2145491015989;394.5738602309499;421.26699542795313;422.84777480107135;425.3237352609366;3398.966010339914;3431.588209414886;3438.1404648837793;3458.4639380896;3552.751307408508;9125.087491250822;9471.66849160276;9576.47329396876;9582.137607615348;9586.520673966274;9558.90441095594;9569.282303827102;9575.808483830284;9581.520923953914;9596.616135354509;7186.317299856505;7251.4923955323675;7262.891056634155;7268.0914885639295;7283.599402032939;4882.316475693477;4903.289023091703;4940.481249468754;5001.64988450805;5164.277001219757;8418.284445822173;8624.655013799378;8835.514046727492;8906.242969347679;8957;8784.297256219616;8970.955145224232;8976.192142707188;9047.68333108338;9100.954495227481;5956.672383018976;6545.37818907203;6600.669966501751;6689;6797.796066118024;7249.637518123967;7295.379892709179;7349.926500734924;7357.742479013209;7372.41020718352;6435.774747883802;6498.220213574401;6614.173228346457;6619.404253617197;6636.469082473294;6476.676166191766;6509.707063182263;6540.444062254572;6615.206175259;6656.933430665631;5895.764169433174;5976.103584462366;5978.073398623221;5989.251343582052;5990.873239999912;4212.431321771522;4240.68194885391;4338.674599404994;4367.803448844873;4418.82324707021;4203.831846726097;4297.119090586485;4335.718178318525;4423.867283981485;4465.106978604227 13:06:48 INFO - PROCESS | 24116 | |4;prototype.html;280.87781814910517;288.98988535401264;291.9343147791748;293.25659453285925;294.39061143433076;4999.47505511921;5009;5018.7992480300745;5029.270755740416;5033.723145227011;4881.974785295083;4896.436909755379;4911.901761964758;4921.75391230438;4924.3105965164905;3699;3706.31433184861;3801.8479260829536;3836.1368692044207;3843.4427008083812;3825.5026846509913;3831.63599458051;3839.2705385976715;3841.3661745811905;3857.729958902878;3803.239352129571;3807.600201978794;3807.9619203807883;3814.9237015259678;3863.130795571002;3587.4260118380935;3781.470594116826;3852;3853.49904512413;3853.614638536152;3315.7015868571943;3319.2697606526526;3326.933461330784;3327.351166522529;3363.9159021024425;4776.785044672998;4792.30511575823;4796.472388037348;4810.759462026885;4817.975910120427;4343.261645520269;4349.13017396522;4362.781860906942;4366.759828209447;4382.846600369004;5000.624953128494;5094.821681241176;5118.718470484122;5135.486451354872;5138.820141295037;3560.3413368526903;3566.9108272293142;3569.428891377393;3579.8926032218815;3584.193556449778;5410.567154627621;5411.161270003156;5423.83728488146;5433.701146436944;5449.291592093003;3476.89569312921;3637.744977982592;3676.724245681531;3681.5398075240596;3761.0785357587565;3718.6839118675216;3724.156542511474;3726.403775395978;3727.9440808387894;3737.794421306854;4305.203537345538;4322.546132656089;4330.17726631939;4340.457442819647;4362.432883725095;5076.18780995039;5143.922841157386;5178.249153872743;5197.246399272084;5219.3736751589295;1269.8857102860602;1296.7925131978839;1300.2523548959198;1307.4508706343358;1309.849367322751;781.7526546210988;799.5402643480022;809.7327881798992;815.649270813544;816.1348970091722;4352.129574085196;4449.844255451044;4548.818047278138;4549.522300158502;4573.954260457419;5307;5311.867203319871;5332.200169974457;5349.465053494697;5358;4541.84103556374;4569.81720731167;4574.679772415965;4575.839845605387;4591.4260717410325;2688.0188731113003;2832.9150125496267;2844.3173638326653;2848.658161020691;2857.4712528796995;5011.273365362002;5026.547610715053;5031.7987280509105;5031.993601279759;5040.2691609716385;5175.611829112831;5464.398916119303;5468.972655136698;5499.1679285168175;5504.798080767725;5012.348394708664;5021.422536408287;5033.496650335011;5036.64743467961;5049.545540901337;5407.026735187704;5428;5432.565394768488;5435.402105768283;5463.53559947393;5165.070287348313;5261.57907367402;5264.236685680631;5290.994711004897;5309.150535914389;5004.724740139327;5006;5021.322121513549;5036.949630503795;5052.065367906802;3718.795466249274;3721.7022638188337;3727.1800203955086;3728.161163738137;3734.79458629778;5116.5673611388875;5357.1696387060065;5417.404085550507;5420.159875219348;5438.728063596884;5229.130443471728;5240.593614150833;5241.50205730455;5247.868803279948;5260.184671375943;5217.738913179263;5221.877296381296;5239.611502951797;5246.501582349671;5254.660061684246;4875.585575226146;5146.485351464824;5161.587073034223;5181.896362072662;5214.7914083436235;5023.34696489454;5073.11220536412;5229.895402092013;5268.552173065333;5275.208718692227;5108.208227724708;5109.310243117132;5117.2835802986865;5124.077666020152;5130.615203859651 13:06:48 INFO - PROCESS | 24116 | |5;yui.html;534.5509771791694;597.4473611908983;601.3745704467351;616.1312549305477;634.6223996721949;11033.613823516169;11697.181197316191;12086.274823510596;12144.574939877095;12178.81731774024;12443.93778031111;12601.62195134145;12646.114771965944;12658.746825063494;12672.112952093357;599.412575675838;716.0941409117471;733.9449541284398;738.0737174845561;738.65283316841;719.4388377065897;743.0563184755384;749.5240522268344;750.2984709296798;754.1892465599475;775.5695588948131;779.5011192836589;780.3718007004359;786.5713186313473;790.0558832195528;775.1744392222294;775.2557544757012;780.9570473623949;785.5836406704399;786.5280831501111;571.5341996273024;574.471486232667;575.3958343739057;576.9394213607553;577.2380457795712;11075.16936229786;11134.33194008362;11141.832872506919;11172;11173.888261117367;13117.672058198526;13580.932095339558;13793.517226897111;13801.792973105412;14064.859351406458;9557.283203759745;9660.420374777535;9725.61097556104;10036.89963100367;10305.278630495868;3184.50640150777;3260.2664400509934;3277.5083737439336;3317.9027675680095;3336.566246387954;64029.35970640281;65958.3404165957;66448;66735;68404;9777.706668799947;9863.753406164904;9908.108270255712;9955.651552195639;10095.091441770275;20090.296839610543;20133.697994530095;20172.899135504227;20175.697364539545;20220.797792022186;6560.606363618198;6661.4004739573675;6663.4669226461765;6719.395254427027;6721.731130754715;3606.8376923038527;3720.7023438124884;3771.698264138862;3791.696664266852;3791.7914514701956;2795.692473827877;2894.0449651615336;2899.2461959890156;2902.680705122435;2911.708829117071;489.6694731056523;492.5493173746054;503.1471655543891;509.8528311299576;511.70065511676086;481.8723038394828;514.531776083762;549.0693274899007;567.6480582039079;593.4006653280218;7331.7638120373795;7523.548587084792;7530.548167109991;7538.623068846536;7753.418493613001;485.6001265922959;535.1357557544616;536.6645846346033;554.3680204566797;564.4017341617898;3496.877609283714;3510;3624.3113808376324;3647.343478173901;3672.3389789838084;95187.52406237925;95349.65104885322;98996;104645;104817;85515.57242213874;88870;90962.54518727497;92723;92811.53594231985;46738;47996.760016199696;50041.499585004414;61113.69443152756;75064.80403957657;6754.3921047106;6803.387695107464;6903.240643529308;7040.647967601702;7168.462365322517;47733.5226647743;47741.52258477371;48464;49372.55646991788;49676;38543.22913541769;51602.48397516127;53578.464215357344;53802.73098634638;59884.10173847483;9837.409755414697;9967.202623789934;10231.386116833013;10338.793224135625;10342.638007669695;11067.72330691739;11471.197016208785;11756.588519402121;11767.941160294144;11813.822792657946;10278.794424111325;10508.42203678805;10546.894531054899;10676.199285053808;10787.406692631981;10486.265961382935;10539.15686745074;10585.417802020655;10783;10856.457177140954;10147.7463063424;10374.481275936323;10456.058954694114;10519.579216831242;10926.890731092906;8300.169983001893;8380.916190838014;8440.409171358191;8778.956105219433;8950.68672596482;8677.826443470969;8728.301735861243;9358.672446464341;9392.624295028123;9458.43249405038 13:06:48 INFO - PROCESS | 24116 | __end_tp_report 13:06:48 INFO - PROCESS | 24116 | __start_cc_report 13:06:48 INFO - PROCESS | 24116 | _x_x_mozilla_cycle_collect,377 13:06:48 INFO - PROCESS | 24116 | __end_cc_report 13:06:48 INFO - PROCESS | 24116 | __startTimestamp1472501208465__endTimestamp 13:06:48 INFO - PROCESS | 24116 | 13:06:48 INFO - PROCESS | 24116 | ------- Summary: start ------- 13:06:48 INFO - PROCESS | 24116 | Number of tests: 6 13:06:48 INFO - PROCESS | 24116 | 13:06:48 INFO - PROCESS | 24116 | [#0] dojo.html Cycles:165 Average:4764.97 Median:4856.76 stddev:514.16 (10.6%) stddev-sans-first:486.67 13:06:48 INFO - PROCESS | 24116 | Values: 2592.4 2606.1 2613.7 2647.5 2648.5 4690.7 4777.1 4789.9 4806.4 4863.7 4744.8 4795.0 4801.1 4856.8 4893.2 4373.3 4403.0 4448.7 4560.9 4562.9 4459.8 4505.8 4533.8 4548.9 4553.2 4298.5 4375.9 4379.7 4404.0 4418.8 4428.4 4429.8 4481.1 4487.6 4489.4 4367.2 4369.1 4392.5 4393.9 4432.7 4709.0 4754.7 4779.4 4810.5 4828.4 5180.6 5182.1 5193.8 5205.2 5233.2 5214.6 5216.7 5219.6 5224.6 5293.0 4711.6 4784.4 4824.2 4828.1 4834.6 5319.8 5320.7 5328.7 5381.7 5394.2 5078.4 5084.4 5084.7 5090.0 5146.0 5026.2 5108.1 5181.6 5184.3 5190.7 5078.1 5094.6 5134.7 5134.9 5141.0 5112.1 5116.3 5120.9 5123.9 5185.1 4235.6 4257.1 4271.0 4354.2 4365.5 3775.4 3787.8 3836.3 3844.6 3860.1 4345.6 4477.6 4478.9 4487.1 4531.1 5050.8 5126.3 5131.3 5194.5 5273.5 4431.6 4447.3 4484.6 4485.9 4490.6 4634.4 4644.2 4645.4 4657.6 4674.8 4738.9 4771.2 4795.0 4841.2 4848.9 5159.8 5185.1 5186.4 5226.4 5248.1 4809.2 4811.3 4813.5 4822.7 4879.8 4979.2 5018.6 5080.7 5081.7 5098.3 5140.9 5158.8 5173.7 5181.0 5228.6 5024.7 5026.8 5027.4 5040.2 5090.3 4760.8 4916.5 4937.2 5001.2 5009.7 4904.5 4917.3 4970.5 5059.6 5065.4 5106.5 5107.4 5107.7 5108.4 5158.8 4950.9 4975.6 4979.0 4990.4 5008.2 13:06:48 INFO - PROCESS | 24116 | 13:06:48 INFO - PROCESS | 24116 | [#1] ext.html Cycles:180 Average:42460.59 Median:19077.72 stddev:75356.21 (395.0%) stddev-sans-first:75501.85 13:06:48 INFO - PROCESS | 24116 | Values: 534.6 548.0 559.1 560.3 590.5 33046.5 38012.8 38017.4 38037.2 38208.6 37511.6 37890.6 37997.4 38044.4 38061.4 7554.1 7722.8 7725.6 7728.7 7730.0 7217.6 7619.3 7648.7 7650.3 7651.1 7641.5 7669.9 7685.4 7692.3 7701.4 7612.9 7635.8 7650.3 7650.5 7661.5 7630.9 7646.0 7684.1 7684.4 7707.5 30552.1 30683.0 30895.0 30895.7 30914.4 3005.7 3132.3 3429.9 3468.0 3483.8 27539.9 27601.7 28325.2 28536.4 29378.9 3374.4 3390.8 3421.2 3434.4 3460.5 173714.0 173734.0 174019.0 174041.1 174966.0 44894.8 45003.3 45059.8 45138.5 45280.5 31672.4 32696.2 52522.5 52987.5 52997.0 14113.6 14629.3 14658.5 14663.6 14704.5 11034.8 11092.6 11102.2 11102.8 11108.4 17297.2 17317.5 17364.7 17508.6 17509.1 6607.2 6631.2 6720.2 6743.8 6897.7 782.9 859.7 899.8 913.7 973.7 26000.6 27538.4 27652.6 27879.9 28136.7 920.5 945.4 954.0 968.6 1037.0 14261.2 14508.3 14723.0 14883.1 14887.6 354100.0 356486.0 356522.0 359773.0 361349.8 46093.5 46629.8 46652.8 46668.0 46933.3 1116.8 1128.6 1133.4 1140.9 1162.5 25126.7 25990.2 26654.3 27135.7 27646.6 41647.8 42015.2 42025.8 42052.0 42054.8 293887.0 295487.0 295658.0 296120.0 297375.0 24632.6 24882.8 24906.4 25023.5 25063.0 39796.6 40038.2 40060.8 40435.4 40715.0 33279.7 33898.5 34263.3 34332.1 34523.7 34687.5 34877.5 35064.3 35107.1 35547.6 27458.1 29865.4 34061.0 34954.5 35108.0 28902.0 31008.5 31090.4 31356.5 31659.5 24162.5 24593.8 24685.6 24857.0 25233.2 13:06:48 INFO - PROCESS | 24116 | 13:06:48 INFO - PROCESS | 24116 | [#2] jquery.html Cycles:180 Average:25488.74 Median:20223.84 stddev:62411.45 (308.6%) stddev-sans-first:62557.99 13:06:48 INFO - PROCESS | 24116 | Values: 348.6 355.8 356.4 368.0 374.2 15760.4 15845.7 16806.5 16898.5 16916.8 14400.3 14845.3 15339.5 15518.0 15521.8 5015.3 6486.2 6776.3 6841.0 6856.5 6710.8 6718.4 6817.7 6833.3 6950.9 6906.2 6942.6 6972.9 6974.2 6978.8 6728.4 6917.9 6997.4 7019.5 7029.8 6541.3 6658.3 6767.8 6774.5 6780.8 22389.8 23000.5 23567.0 23572.6 23729.0 2056.7 2110.4 2239.5 2328.4 2445.9 13947.8 14102.9 14437.5 14914.4 15323.9 1781.0 1815.4 1893.2 1919.1 1959.6 80240.6 81041.6 81662.0 82191.0 83331.6 15878.4 16307.0 16506.1 16615.3 16704.2 27502.4 27623.6 27823.4 27927.6 28166.7 8352.9 8486.0 8502.9 8600.9 8768.2 6799.6 6891.7 7049.1 7078.0 7106.3 7787.6 7970.9 8285.5 8341.0 8430.4 3065.7 3236.0 3238.2 3365.9 3411.8 762.7 794.8 813.5 827.4 885.5 16192.4 16780.2 16863.9 17281.3 17510.0 390.8 404.9 408.2 763.3 799.3 5399.8 5565.4 5665.8 5716.8 5900.9 367711.0 374535.0 376285.0 377536.0 378081.0 83520.0 83799.6 83967.6 86119.6 86791.6 406.0 422.5 425.6 425.6 427.4 10086.8 10096.2 10252.3 10342.4 10684.3 38651.6 39847.6 39856.4 40042.8 41164.6 54430.0 54595.7 54648.7 55521.7 55761.7 7577.3 7602.4 7611.1 7835.7 7857.6 8826.0 11343.8 11761.3 11781.1 12054.5 9970.8 10311.5 10419.6 10630.4 10957.8 6566.4 10361.4 10417.6 10448.6 11067.7 10208.5 10385.6 10971.7 11017.2 11052.7 7341.7 7590.7 7715.5 7849.8 8080.2 9983.4 10267.9 10333.6 10388.8 10741.1 13:06:48 INFO - PROCESS | 24116 | 13:06:48 INFO - PROCESS | 24116 | [#3] mootools.html Cycles:180 Average:5003.82 Median:4780.39 stddev:2842.73 (59.5%) stddev-sans-first:2837.33 13:06:48 INFO - PROCESS | 24116 | Values: 1333.9 1381.9 1453.7 1615.9 1691.9 6805.9 7262.7 7344.7 7907.3 7916.3 7273.2 7461.7 7461.9 7471.1 7471.5 2144.5 2171.2 2173.5 2182.2 2183.9 2120.2 2147.7 2173.2 2178.6 2179.0 2140.0 2165.0 2181.3 2182.3 2193.2 2119.8 2129.6 2133.2 2139.0 2141.2 2050.5 2100.2 2103.8 2121.2 2127.5 7547.4 7660.0 7722.9 7723.5 7729.5 4363.4 4508.5 4513.5 4526.1 4533.1 2822.6 2869.4 2975.8 2985.1 2987.5 890.5 929.3 953.8 959.7 961.1 10475.4 10496.2 10498.4 10532.1 10542.6 3800.3 3974.7 4098.4 4102.1 4204.6 8892.6 8917.0 8918.1 8949.4 8969.3 4567.0 4570.6 4588.6 4588.8 4591.4 3668.3 3948.2 4074.7 4136.0 4176.1 3564.9 3623.3 3635.3 3640.8 3713.9 1168.5 1174.5 1189.6 1190.3 1193.3 775.7 777.8 790.7 808.0 813.8 4761.6 4799.2 4863.2 4907.3 5049.3 382.2 394.6 421.3 422.8 425.3 3399.0 3431.6 3438.1 3458.5 3552.8 9125.1 9471.7 9576.5 9582.1 9586.5 9558.9 9569.3 9575.8 9581.5 9596.6 7186.3 7251.5 7262.9 7268.1 7283.6 4882.3 4903.3 4940.5 5001.6 5164.3 8418.3 8624.7 8835.5 8906.2 8957.0 8784.3 8971.0 8976.2 9047.7 9101.0 5956.7 6545.4 6600.7 6689.0 6797.8 7249.6 7295.4 7349.9 7357.7 7372.4 6435.8 6498.2 6614.2 6619.4 6636.5 6476.7 6509.7 6540.4 6615.2 6656.9 5895.8 5976.1 5978.1 5989.3 5990.9 4212.4 4240.7 4338.7 4367.8 4418.8 4203.8 4297.1 4335.7 4423.9 4465.1 13:06:48 INFO - PROCESS | 24116 | 13:06:48 INFO - PROCESS | 24116 | [#4] prototype.html Cycles:180 Average:4287.94 Median:4961.89 stddev:1274.37 (25.7%) stddev-sans-first:1241.95 13:06:48 INFO - PROCESS | 24116 | Values: 280.9 289.0 291.9 293.3 294.4 4999.5 5009.0 5018.8 5029.3 5033.7 4882.0 4896.4 4911.9 4921.8 4924.3 3699.0 3706.3 3801.8 3836.1 3843.4 3825.5 3831.6 3839.3 3841.4 3857.7 3803.2 3807.6 3808.0 3814.9 3863.1 3587.4 3781.5 3852.0 3853.5 3853.6 3315.7 3319.3 3326.9 3327.4 3363.9 4776.8 4792.3 4796.5 4810.8 4818.0 4343.3 4349.1 4362.8 4366.8 4382.8 5000.6 5094.8 5118.7 5135.5 5138.8 3560.3 3566.9 3569.4 3579.9 3584.2 5410.6 5411.2 5423.8 5433.7 5449.3 3476.9 3637.7 3676.7 3681.5 3761.1 3718.7 3724.2 3726.4 3727.9 3737.8 4305.2 4322.5 4330.2 4340.5 4362.4 5076.2 5143.9 5178.2 5197.2 5219.4 1269.9 1296.8 1300.3 1307.5 1309.8 781.8 799.5 809.7 815.6 816.1 4352.1 4449.8 4548.8 4549.5 4574.0 5307.0 5311.9 5332.2 5349.5 5358.0 4541.8 4569.8 4574.7 4575.8 4591.4 2688.0 2832.9 2844.3 2848.7 2857.5 5011.3 5026.5 5031.8 5032.0 5040.3 5175.6 5464.4 5469.0 5499.2 5504.8 5012.3 5021.4 5033.5 5036.6 5049.5 5407.0 5428.0 5432.6 5435.4 5463.5 5165.1 5261.6 5264.2 5291.0 5309.2 5004.7 5006.0 5021.3 5036.9 5052.1 3718.8 3721.7 3727.2 3728.2 3734.8 5116.6 5357.2 5417.4 5420.2 5438.7 5229.1 5240.6 5241.5 5247.9 5260.2 5217.7 5221.9 5239.6 5246.5 5254.7 4875.6 5146.5 5161.6 5181.9 5214.8 5023.3 5073.1 5229.9 5268.6 5275.2 5108.2 5109.3 5117.3 5124.1 5130.6 13:06:48 INFO - PROCESS | 24116 | 13:06:48 INFO - PROCESS | 24116 | [#5] yui.html Cycles:180 Average:17034.08 Median:26068.52 stddev:25095.25 (96.3%) stddev-sans-first:25135.07 13:06:48 INFO - PROCESS | 24116 | Values: 534.6 597.4 601.4 616.1 634.6 11033.6 11697.2 12086.3 12144.6 12178.8 12443.9 12601.6 12646.1 12658.7 12672.1 599.4 716.1 733.9 738.1 738.7 719.4 743.1 749.5 750.3 754.2 775.6 779.5 780.4 786.6 790.1 775.2 775.3 781.0 785.6 786.5 571.5 574.5 575.4 576.9 577.2 11075.2 11134.3 11141.8 11172.0 11173.9 13117.7 13580.9 13793.5 13801.8 14064.9 9557.3 9660.4 9725.6 10036.9 10305.3 3184.5 3260.3 3277.5 3317.9 3336.6 64029.4 65958.3 66448.0 66735.0 68404.0 9777.7 9863.8 9908.1 9955.7 10095.1 20090.3 20133.7 20172.9 20175.7 20220.8 6560.6 6661.4 6663.5 6719.4 6721.7 3606.8 3720.7 3771.7 3791.7 3791.8 2795.7 2894.0 2899.2 2902.7 2911.7 489.7 492.5 503.1 509.9 511.7 481.9 514.5 549.1 567.6 593.4 7331.8 7523.5 7530.5 7538.6 7753.4 485.6 535.1 536.7 554.4 564.4 3496.9 3510.0 3624.3 3647.3 3672.3 95187.5 95349.7 98996.0 104645.0 104817.0 85515.6 88870.0 90962.5 92723.0 92811.5 46738.0 47996.8 50041.5 61113.7 75064.8 6754.4 6803.4 6903.2 7040.6 7168.5 47733.5 47741.5 48464.0 49372.6 49676.0 38543.2 51602.5 53578.5 53802.7 59884.1 9837.4 9967.2 10231.4 10338.8 10342.6 11067.7 11471.2 11756.6 11767.9 11813.8 10278.8 10508.4 10546.9 10676.2 10787.4 10486.3 10539.2 10585.4 10783.0 10856.5 10147.7 10374.5 10456.1 10519.6 10926.9 8300.2 8380.9 8440.4 8779.0 8950.7 8677.8 8728.3 9358.7 9392.6 9458.4 13:06:48 INFO - PROCESS | 24116 | -------- Summary: end -------- 13:06:48 INFO - PROCESS | 24116 | 13:06:49 INFO - TEST-INFO | 24116: exit 0 13:06:49 INFO - TEST-OK | dromaeo_css | took 1118615ms 13:06:49 INFO - TEST-START | kraken 13:06:49 INFO - operating with platform_type : linux_ 13:06:49 INFO - Initialising browser for kraken test... 13:06:49 INFO - TEST-INFO | started process 24464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFmux2V/profile http://localhost:52978/getInfo.html) 13:06:54 INFO - PROCESS | 24464 | __metrics Screen width/height:1600/1200 13:06:54 INFO - PROCESS | 24464 | colorDepth:24 13:06:54 INFO - PROCESS | 24464 | Browser inner width/height: 1024/697 13:06:54 INFO - PROCESS | 24464 | __metrics 13:06:55 ERROR - PROCESS | 24464 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 13:06:56 INFO - TEST-INFO | 24464: exit 0 13:06:56 INFO - Browser initialized. 13:06:56 INFO - Running cycle 1/1 for kraken test... 13:06:56 INFO - TEST-INFO | started process 24585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFmux2V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:08 INFO - PROCESS | 24585 | RSS: Main: 193028096 13:07:08 INFO - PROCESS | 24585 | 13:07:11 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52978/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:12 INFO - PROCESS | 24585 | RSS: Main: 205713408 13:07:12 INFO - PROCESS | 24585 | 13:07:15 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52978/tests/kraken/driver.html?testName=audio-dft) 13:07:15 INFO - PROCESS | 24585 | RSS: Main: 204967936 13:07:15 INFO - PROCESS | 24585 | 13:07:18 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52978/tests/kraken/driver.html?testName=audio-fft) 13:07:19 INFO - PROCESS | 24585 | RSS: Main: 196030464 13:07:19 INFO - PROCESS | 24585 | 13:07:21 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52978/tests/kraken/driver.html?testName=audio-oscillator) 13:07:22 INFO - PROCESS | 24585 | RSS: Main: 196349952 13:07:22 INFO - PROCESS | 24585 | 13:07:24 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:07:24 INFO - PROCESS | 24585 | RSS: Main: 196411392 13:07:24 INFO - PROCESS | 24585 | 13:07:28 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52978/tests/kraken/driver.html?testName=imaging-darkroom) 13:07:28 INFO - PROCESS | 24585 | RSS: Main: 196259840 13:07:28 INFO - PROCESS | 24585 | 13:07:32 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52978/tests/kraken/driver.html?testName=imaging-desaturate) 13:07:32 INFO - PROCESS | 24585 | RSS: Main: 193990656 13:07:32 INFO - PROCESS | 24585 | 13:07:35 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52978/tests/kraken/driver.html?testName=json-parse-financial) 13:07:36 INFO - PROCESS | 24585 | RSS: Main: 195792896 13:07:36 INFO - PROCESS | 24585 | 13:07:38 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:07:38 INFO - PROCESS | 24585 | RSS: Main: 196186112 13:07:38 INFO - PROCESS | 24585 | 13:07:40 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52978/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:07:41 INFO - PROCESS | 24585 | RSS: Main: 196235264 13:07:41 INFO - PROCESS | 24585 | 13:07:43 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:07:44 INFO - PROCESS | 24585 | RSS: Main: 196984832 13:07:44 INFO - PROCESS | 24585 | 13:07:47 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:07:47 INFO - PROCESS | 24585 | RSS: Main: 196734976 13:07:47 INFO - PROCESS | 24585 | 13:07:50 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:07:51 INFO - PROCESS | 24585 | RSS: Main: 197173248 13:07:51 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52978/tests/kraken/driver.html?testName=ai-astar) 13:07:53 INFO - PROCESS | 24585 | RSS: Main: 198705152 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | __start_tp_report 13:07:53 INFO - PROCESS | 24585 | _x_x_mozilla_page_load 13:07:53 INFO - PROCESS | 24585 | _x_x_mozilla_page_load_details 13:07:53 INFO - PROCESS | 24585 | |i|pagename|runs| 13:07:53 INFO - PROCESS | 24585 | |0;ai-astar;111;116;116;114;115;115;124;116;116;135 13:07:53 INFO - PROCESS | 24585 | |1;audio-beat-detection;158;123;148;192;124;158;154;127;183;129 13:07:53 INFO - PROCESS | 24585 | |2;audio-dft;180;165;163;163;164;165;165;167;167;164 13:07:53 INFO - PROCESS | 24585 | |3;audio-fft;77;77;77;170;78;77;78;77;162;78 13:07:53 INFO - PROCESS | 24585 | |4;audio-oscillator;83;85;131;84;85;85;136;83;84;136 13:07:53 INFO - PROCESS | 24585 | |5;imaging-gaussian-blur;119;118;119;119;118;118;119;118;118;118 13:07:53 INFO - PROCESS | 24585 | |6;imaging-darkroom;148;147;149;147;148;148;148;150;149;150 13:07:53 INFO - PROCESS | 24585 | |7;imaging-desaturate;95;96;97;97;96;96;96;96;96;96 13:07:53 INFO - PROCESS | 24585 | |8;json-parse-financial;65;68;67;66;66;68;67;66;67;69 13:07:53 INFO - PROCESS | 24585 | |9;json-stringify-tinderbox;69;66;65;65;66;66;66;66;70;65 13:07:53 INFO - PROCESS | 24585 | |10;stanford-crypto-aes;85;86;88;83;83;83;82;88;85;83 13:07:53 INFO - PROCESS | 24585 | |11;stanford-crypto-ccm;138;153;143;139;143;133;133;142;180;146 13:07:53 INFO - PROCESS | 24585 | |12;stanford-crypto-pbkdf2;175;175;172;175;178;178;174;172;172;177 13:07:53 INFO - PROCESS | 24585 | |13;stanford-crypto-sha256-iterative;71;72;72;71;72;74;74;70;69;70 13:07:53 INFO - PROCESS | 24585 | __end_tp_report 13:07:53 INFO - PROCESS | 24585 | __start_cc_report 13:07:53 INFO - PROCESS | 24585 | _x_x_mozilla_cycle_collect,892 13:07:53 INFO - PROCESS | 24585 | __end_cc_report 13:07:53 INFO - PROCESS | 24585 | __startTimestamp1472501273402__endTimestamp 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | ------- Summary: start ------- 13:07:53 INFO - PROCESS | 24585 | Number of tests: 14 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#0] ai-astar Cycles:10 Average:117.80 Median:116.00 stddev:6.86 (5.9%) stddev-sans-first:6.82 13:07:53 INFO - PROCESS | 24585 | Values: 111.0 116.0 116.0 114.0 115.0 115.0 124.0 116.0 116.0 135.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.00 stddev:24.44 (15.7%) stddev-sans-first:25.73 13:07:53 INFO - PROCESS | 24585 | Values: 158.0 123.0 148.0 192.0 124.0 158.0 154.0 127.0 183.0 129.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#2] audio-dft Cycles:10 Average:166.30 Median:165.00 stddev:5.01 (3.0%) stddev-sans-first:1.48 13:07:53 INFO - PROCESS | 24585 | Values: 180.0 165.0 163.0 163.0 164.0 165.0 165.0 167.0 167.0 164.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#3] audio-fft Cycles:10 Average:95.10 Median:77.00 stddev:37.42 (48.6%) stddev-sans-first:39.11 13:07:53 INFO - PROCESS | 24585 | Values: 77.0 77.0 77.0 170.0 78.0 77.0 78.0 77.0 162.0 78.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#4] audio-oscillator Cycles:10 Average:99.20 Median:84.00 stddev:24.29 (28.9%) stddev-sans-first:25.05 13:07:53 INFO - PROCESS | 24585 | Values: 83.0 85.0 131.0 84.0 85.0 85.0 136.0 83.0 84.0 136.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:07:53 INFO - PROCESS | 24585 | Values: 119.0 118.0 119.0 119.0 118.0 118.0 119.0 118.0 118.0 118.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 13:07:53 INFO - PROCESS | 24585 | Values: 148.0 147.0 149.0 147.0 148.0 148.0 148.0 150.0 149.0 150.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 13:07:53 INFO - PROCESS | 24585 | Values: 95.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.05 13:07:53 INFO - PROCESS | 24585 | Values: 65.0 68.0 67.0 66.0 66.0 68.0 67.0 66.0 67.0 69.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:1.71 (2.6%) stddev-sans-first:1.54 13:07:53 INFO - PROCESS | 24585 | Values: 69.0 66.0 65.0 65.0 66.0 66.0 66.0 66.0 70.0 65.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:2.17 (2.6%) stddev-sans-first:2.30 13:07:53 INFO - PROCESS | 24585 | Values: 85.0 86.0 88.0 83.0 83.0 83.0 82.0 88.0 85.0 83.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:143.00 stddev:13.66 (9.6%) stddev-sans-first:14.25 13:07:53 INFO - PROCESS | 24585 | Values: 138.0 153.0 143.0 139.0 143.0 133.0 133.0 142.0 180.0 146.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.00 stddev:2.35 (1.3%) stddev-sans-first:2.49 13:07:53 INFO - PROCESS | 24585 | Values: 175.0 175.0 172.0 175.0 178.0 178.0 174.0 172.0 172.0 177.0 13:07:53 INFO - PROCESS | 24585 | 13:07:53 INFO - PROCESS | 24585 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.65 (2.3%) stddev-sans-first:1.74 13:07:53 INFO - PROCESS | 24585 | Values: 71.0 72.0 72.0 71.0 72.0 74.0 74.0 70.0 69.0 70.0 13:07:53 INFO - PROCESS | 24585 | -------- Summary: end -------- 13:07:53 INFO - PROCESS | 24585 | 13:07:54 INFO - TEST-INFO | 24585: exit 0 13:07:54 INFO - TEST-OK | kraken | took 65072ms 13:07:54 INFO - SUITE-END | took 1183s 13:07:55 INFO - Completed test suite (00:19:44) 13:07:55 INFO - javascript benchmark 13:07:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6351.170775937967, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.44262483566, 2606.087869245763, 2613.6732908386452, 2647.536681080811, 2648.4835457085874, 4690.671652984292, 4777.092352453036, 4789.904201915964, 4806.423229212491, 4863.708177509352, 4744.833930812422, 4795.040991801645, 4801.063792560452, 4856.7571621418965, 4893.2170852663585, 4373.300271956487, 4403.031333106712, 4448.733076015434, 4560.931586026196, 4562.885927851797, 4459.843905463309, 4505.8422955196575, 4533.818647254106, 4548.931766023512, 4553.248713962193, 4298.46269216348, 4375.868723938287, 4379.715318504287, 4404.031113155101, 4418.8453404130705, 4428.4243048403505, 4429.844955426544, 4481.058977614704, 4487.551244875519, 4489.416375871148, 4367.213901497729, 4369.082492676542, 4392.450943632046, 4393.934090988638, 4432.734035957853, 4708.952910470885, 4754.66717329787, 4779.426468823764, 4810.494898035691, 4828.420589529243, 5180.585553155738, 5182.144946083891, 5193.766280517348, 5205.219217117425, 5233.241180028875, 5214.556762675177, 5216.739163041871, 5219.582433405357, 5224.63427560071, 5292.973535132338, 4711.599514041345, 4784.354112194878, 4824.155772739791, 4828.058528586892, 4834.564889159922, 5319.840404787863, 5320.654157479751, 5328.653637513627, 5381.730913454312, 5394.190871369326, 5078.415982162025, 5084.389873215164, 5084.720340381241, 5090.0, 5145.974270128625, 5026.170681837529, 5108.131617624938, 5181.5854731621375, 5184.300119483897, 5190.740462976836, 5078.085944529947, 5094.643374963791, 5134.691918484903, 5134.897302053938, 5140.974295128501, 5112.105381558213, 5116.304548102932, 5120.948790512047, 5123.8719032023755, 5185.144451165515, 4235.555266697014, 4257.148570285955, 4270.978645106817, 4354.172707185625, 4365.519792822787, 3775.414810704345, 3787.791671458041, 3836.290286296988, 3844.557875844258, 3860.1314704191896, 4345.587169218919, 4477.552244775497, 4478.932816007762, 4487.147441986078, 4531.093781243764, 5050.823221187241, 5126.282320475137, 5131.307273518028, 5194.480551944851, 5273.472652734773, 4431.645468362523, 4447.288433850633, 4484.551544845554, 4485.865424037284, 4490.640748740158, 4634.374359461497, 4644.233701439292, 4645.442546894395, 4657.580817726353, 4674.766261686902, 4738.857834264978, 4771.23660214364, 4795.0, 4841.249606310957, 4848.854534363974, 5159.845204643867, 5185.09260879337, 5186.377634683862, 5226.425093239664, 5248.1340578804065, 4809.182438985311, 4811.302361157683, 4813.4945830688675, 4822.71063736177, 4879.804807807648, 4979.203327467588, 5018.573421259088, 5080.695158290367, 5081.695098294114, 5098.260752190838, 5140.897182056263, 5158.819441319536, 5173.715445650525, 5181.0, 5228.6078544110105, 5024.748762561784, 5026.798928042837, 5027.396712394536, 5040.218766091261, 5090.261912022662, 4760.833370832004, 4916.532929371704, 4937.160682683881, 5001.174806156943, 5009.699418034929, 4904.509549045067, 4917.311576379238, 4970.478099799614, 5059.5952323814745, 5065.417476990193, 5106.540411362995, 5107.387113546398, 5107.719075450886, 5108.412532558655, 5158.767855446439, 4950.925736113889, 4975.626827987843, 4978.950210497848, 4990.3762029746285, 5008.198688210015], "value": 4730.788881638997, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.599050711966, 547.9561435465439, 559.0719405786396, 560.327606871754, 590.4803772680041, 33046.50430243545, 38012.80993595028, 38017.429738553874, 38037.23925521488, 38208.61791382085, 37511.62488375115, 37890.62109378906, 37997.43003854944, 38044.429333560016, 38061.429078563844, 7554.131274903374, 7722.768316950501, 7725.61371931404, 7728.690852365927, 7729.995100636909, 7217.566945983232, 7619.314261716444, 7648.732294369698, 7650.273224043734, 7651.120121186079, 7641.54150750954, 7669.884951725729, 7685.423593230502, 7692.3076923076915, 7701.383889288843, 7612.885806712876, 7635.770926872203, 7650.349720273728, 7650.54096754191, 7661.502002369828, 7630.8855367169535, 7645.961770191169, 7684.077910650702, 7684.385249180053, 7707.537547747097, 30552.08343749691, 30683.0, 30895.0, 30895.691043089508, 30914.381712365626, 3005.6994300569986, 3132.342208136294, 3429.8971030869116, 3467.9653203467897, 3483.825808709554, 27539.862300688368, 27601.723982760115, 28325.150245492463, 28536.429271414454, 29378.853105734335, 3374.358871814372, 3390.762646614738, 3421.161815355229, 3434.433318502469, 3460.5155278260813, 173714.0, 173734.0, 174019.0, 174041.1297943515, 174966.0, 44894.77552612216, 45003.324950125774, 45059.77470112628, 45138.54861451409, 45280.54719452763, 31672.366552668816, 32696.182595434828, 52522.47477525252, 52987.47012529903, 52997.0, 14113.647158821112, 14629.268536573341, 14658.486952956808, 14663.56009319722, 14704.485343012942, 11034.779304413867, 11092.55629774816, 11102.167337449724, 11102.833457498144, 11108.389038602792, 17297.221625026905, 17317.4804755855, 17364.739528907077, 17508.649827003388, 17509.12454377276, 6607.2071351438135, 6631.204255489276, 6720.22717387497, 6743.831404214836, 6897.7240910363025, 782.9060512738508, 859.6905114158898, 899.7750562359411, 913.7350168451208, 973.6835528453139, 26000.609990850153, 27538.449231015267, 27652.617369131865, 27879.860600696866, 28136.71863281382, 920.4891285336703, 945.385499425379, 953.9713808585753, 968.5593055159885, 1036.9585216591252, 14261.21563314007, 14508.347124379428, 14723.0, 14883.10701357922, 14887.553373398816, 354100.0, 356486.0, 356522.0, 359773.0, 361349.77300453844, 46093.5390646096, 46629.766851166205, 46652.7667361661, 46668.0, 46933.29600056002, 1116.7543140509238, 1128.644476989762, 1133.3992983718642, 1140.8916152965455, 1162.511745067074, 25126.748732512442, 25990.220293391227, 26654.333641659112, 27135.72864271411, 27646.5853012209, 41647.791761041, 42015.159696806506, 42025.78987105045, 42052.0, 42054.789726051175, 293887.0, 295487.0, 295658.0, 296120.0, 297375.0, 24632.630510542716, 24882.751172488766, 24906.377340566632, 25023.499530009663, 25063.0, 39796.602033980445, 40038.19923601453, 40060.7996960025, 40435.39346909858, 40715.0, 33279.667203327655, 33898.49152262669, 34263.31473370569, 34332.14169645779, 34523.65476345205, 34687.479687804196, 34877.47683784796, 35064.29871402609, 35107.12232194216, 35547.64452355443, 27458.119861789586, 29865.402691946474, 34061.0, 34954.47568286427, 35108.0, 28902.0, 31008.53487197739, 31090.378192436478, 31356.529652055695, 31659.52510712295, 24162.51674966526, 24593.754062459146, 24685.62971555392, 24857.0, 25233.243002709947], "value": 16601.38778703158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.5956290702785, 355.8203107430747, 356.4439474419904, 367.97056235501145, 374.23469005882964, 15760.448384306552, 15845.683086338266, 16806.49580512585, 16898.493045208634, 16916.83083169168, 14400.27998600071, 14845.331960061796, 15339.539813805575, 15518.0, 15521.844781552209, 5015.297858299841, 6486.221653401575, 6776.2546119926765, 6841.0, 6856.485763567727, 6710.765123220688, 6718.42893354063, 6817.727290908382, 6833.316668333152, 6950.895736563955, 6906.205786334561, 6942.583444993291, 6972.930270697304, 6974.232834388238, 6978.790636280894, 6728.394444500019, 6917.89623155653, 6997.440204783605, 7019.473539484508, 7029.82425439363, 6541.313162117956, 6658.334166583303, 6767.763128290536, 6774.5257831951785, 6780.796576102724, 22389.77610223893, 23000.539989200122, 23567.0, 23572.64641030386, 23729.0, 2056.691496275556, 2110.398536417129, 2239.5423240608734, 2328.4295347639936, 2445.9388515287083, 13947.790783138262, 14102.92948535261, 14437.494687685881, 14914.403423863141, 15323.923380383138, 1780.9821901781077, 1815.4190658989128, 1893.1575448925234, 1919.0500702152524, 1959.6472634925708, 80240.59879700623, 81041.59479202626, 81662.0, 82191.0, 83331.5833420829, 15878.364865405254, 16307.0, 16506.092164930804, 16615.335386584644, 16704.248308826132, 27502.44995100127, 27623.585646215324, 27823.443531129265, 27927.58108628372, 28166.71833281682, 8352.916470835335, 8486.0, 8502.914970850212, 8600.8709869352, 8768.210861022411, 6799.626020568818, 6891.655417229219, 7049.08361912948, 7077.964610176916, 7106.289371062956, 7787.610619469117, 7970.920290797134, 8285.50286982783, 8341.0, 8430.367722420842, 3065.724084832376, 3235.9581992926574, 3238.1904523869034, 3365.882194123194, 3411.812350320756, 762.7216066135932, 794.8410317936435, 813.5281536708695, 827.4373426070209, 885.5395194498825, 16192.352305907632, 16780.160991950597, 16863.915680421764, 17281.308747649953, 17510.02329603945, 390.785068212482, 404.88865561970107, 408.2182620282126, 763.2596381509926, 799.2886331165267, 5399.78400863961, 5565.443455654402, 5665.830025099253, 5716.828495145152, 5900.911486327708, 367711.0, 374535.0, 376285.0, 377536.0, 378081.0, 83520.0, 83799.58100209582, 83967.58016209879, 86119.56940215384, 86791.56604216939, 405.98579049733115, 422.5352112676093, 425.5871804349776, 425.64883970723656, 427.367496105759, 10086.8486972694, 10096.19230461576, 10252.333598316085, 10342.37945723259, 10684.305520141166, 38651.61348386593, 39847.60152398555, 39856.402153968294, 40042.79978600088, 41164.58835411727, 54430.0, 54595.72702136464, 54648.72675636596, 55521.72239138778, 55761.721191393786, 7577.332986742907, 7602.391808655184, 7611.124720657195, 7835.686572537034, 7857.646405911862, 8826.02913679482, 11343.829842552534, 11761.294322340687, 11781.116416268986, 12054.51781928713, 9970.750731231778, 10311.535980880728, 10419.635312764018, 10630.415327157081, 10957.780844383227, 6566.409023187745, 10361.393983932503, 10417.583296668048, 10448.58205671795, 11067.667969960592, 10208.489575521342, 10385.63650272237, 10971.670849874517, 11017.237242041236, 11052.723681908017, 7341.74303899361, 7590.658420371207, 7715.4599178057, 7849.843003140019, 8080.191980801873, 9983.400995940267, 10267.94866025665, 10333.638322658671, 10388.792224155324, 10741.087007604441], "value": 8811.187416008514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.8999575031871, 1381.930903454827, 1453.7165252775712, 1615.9111248881306, 1691.8815682902193, 6805.863882722342, 7262.673179706912, 7344.706211751523, 7907.288344049034, 7916.2875341219205, 7273.236310187421, 7461.738839140631, 7461.850762984737, 7471.103467583897, 7471.514351567144, 2144.4638840289927, 2171.240065976903, 2173.478365192358, 2182.203495724057, 2183.879886606236, 2120.162535798359, 2147.6885851551515, 2173.1850556041486, 2178.5533965537106, 2178.9782102179015, 2140.0, 2165.0257384177185, 2181.269274792938, 2182.2689399051337, 2193.1994821889975, 2119.8092171704466, 2129.606022885771, 2133.168064454856, 2138.9786102138937, 2141.1649456711816, 2050.487378155461, 2100.19142630087, 2103.779103194158, 2121.2045482943895, 2127.5213077057692, 7547.358474529671, 7660.0, 7722.884156737653, 7723.459357844953, 7729.497582657109, 4363.367311739812, 4508.549145085465, 4513.480949690795, 4526.072155208174, 4533.070720502289, 2822.604835323036, 2869.411770587025, 2975.8363290019042, 2985.1044686593937, 2987.521996480553, 890.528020149322, 929.3262384771054, 953.8330792111353, 959.6593209410629, 961.0821665309683, 10475.423851688154, 10496.21278404115, 10498.422586757726, 10532.104771094466, 10542.631007914762, 3800.315943130263, 3974.701897357652, 4098.364753463218, 4102.077032667626, 4204.579542045833, 8892.64429422816, 8917.019127895926, 8918.10818918103, 8949.418287811272, 8969.282457403391, 4566.97716511422, 4570.588647021717, 4588.632909367243, 4588.816447342069, 4591.4260717410325, 3668.2663467306647, 3948.190620922704, 4074.7351422157467, 4136.048708796993, 4176.14389050244, 3564.8930532084078, 3623.329684008414, 3635.327464419091, 3640.8361623726996, 3713.9071523212137, 1168.5092261250295, 1174.5008371442275, 1189.5539172810197, 1190.3096204201543, 1193.2601786892183, 775.6625867747548, 777.8327659553111, 790.6639678136769, 807.9636416361278, 813.829095889858, 4761.571458568746, 4799.208130658402, 4863.197572400514, 4907.263910413467, 5049.31834202378, 382.2145491015989, 394.5738602309499, 421.26699542795313, 422.84777480107135, 425.3237352609366, 3398.966010339914, 3431.588209414886, 3438.1404648837793, 3458.4639380896, 3552.751307408508, 9125.087491250822, 9471.66849160276, 9576.47329396876, 9582.137607615348, 9586.520673966274, 9558.90441095594, 9569.282303827102, 9575.808483830284, 9581.520923953914, 9596.616135354509, 7186.317299856505, 7251.4923955323675, 7262.891056634155, 7268.0914885639295, 7283.599402032939, 4882.316475693477, 4903.289023091703, 4940.481249468754, 5001.64988450805, 5164.277001219757, 8418.284445822173, 8624.655013799378, 8835.514046727492, 8906.242969347679, 8957.0, 8784.297256219616, 8970.955145224232, 8976.192142707188, 9047.68333108338, 9100.954495227481, 5956.672383018976, 6545.37818907203, 6600.669966501751, 6689.0, 6797.796066118024, 7249.637518123967, 7295.379892709179, 7349.926500734924, 7357.742479013209, 7372.41020718352, 6435.774747883802, 6498.220213574401, 6614.173228346457, 6619.404253617197, 6636.469082473294, 6476.676166191766, 6509.707063182263, 6540.444062254572, 6615.206175259, 6656.933430665631, 5895.764169433174, 5976.103584462366, 5978.073398623221, 5989.251343582052, 5990.873239999912, 4212.431321771522, 4240.68194885391, 4338.674599404994, 4367.803448844873, 4418.82324707021, 4203.831846726097, 4297.119090586485, 4335.718178318525, 4423.867283981485, 4465.106978604227], "value": 3965.765095515781, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.87781814910517, 288.98988535401264, 291.9343147791748, 293.25659453285925, 294.39061143433076, 4999.47505511921, 5009.0, 5018.7992480300745, 5029.270755740416, 5033.723145227011, 4881.974785295083, 4896.436909755379, 4911.901761964758, 4921.75391230438, 4924.3105965164905, 3699.0, 3706.31433184861, 3801.8479260829536, 3836.1368692044207, 3843.4427008083812, 3825.5026846509913, 3831.63599458051, 3839.2705385976715, 3841.3661745811905, 3857.729958902878, 3803.239352129571, 3807.600201978794, 3807.9619203807883, 3814.9237015259678, 3863.130795571002, 3587.4260118380935, 3781.470594116826, 3852.0, 3853.49904512413, 3853.614638536152, 3315.7015868571943, 3319.2697606526526, 3326.933461330784, 3327.351166522529, 3363.9159021024425, 4776.785044672998, 4792.30511575823, 4796.472388037348, 4810.759462026885, 4817.975910120427, 4343.261645520269, 4349.13017396522, 4362.781860906942, 4366.759828209447, 4382.846600369004, 5000.624953128494, 5094.821681241176, 5118.718470484122, 5135.486451354872, 5138.820141295037, 3560.3413368526903, 3566.9108272293142, 3569.428891377393, 3579.8926032218815, 3584.193556449778, 5410.567154627621, 5411.161270003156, 5423.83728488146, 5433.701146436944, 5449.291592093003, 3476.89569312921, 3637.744977982592, 3676.724245681531, 3681.5398075240596, 3761.0785357587565, 3718.6839118675216, 3724.156542511474, 3726.403775395978, 3727.9440808387894, 3737.794421306854, 4305.203537345538, 4322.546132656089, 4330.17726631939, 4340.457442819647, 4362.432883725095, 5076.18780995039, 5143.922841157386, 5178.249153872743, 5197.246399272084, 5219.3736751589295, 1269.8857102860602, 1296.7925131978839, 1300.2523548959198, 1307.4508706343358, 1309.849367322751, 781.7526546210988, 799.5402643480022, 809.7327881798992, 815.649270813544, 816.1348970091722, 4352.129574085196, 4449.844255451044, 4548.818047278138, 4549.522300158502, 4573.954260457419, 5307.0, 5311.867203319871, 5332.200169974457, 5349.465053494697, 5358.0, 4541.84103556374, 4569.81720731167, 4574.679772415965, 4575.839845605387, 4591.4260717410325, 2688.0188731113003, 2832.9150125496267, 2844.3173638326653, 2848.658161020691, 2857.4712528796995, 5011.273365362002, 5026.547610715053, 5031.7987280509105, 5031.993601279759, 5040.2691609716385, 5175.611829112831, 5464.398916119303, 5468.972655136698, 5499.1679285168175, 5504.798080767725, 5012.348394708664, 5021.422536408287, 5033.496650335011, 5036.64743467961, 5049.545540901337, 5407.026735187704, 5428.0, 5432.565394768488, 5435.402105768283, 5463.53559947393, 5165.070287348313, 5261.57907367402, 5264.236685680631, 5290.994711004897, 5309.150535914389, 5004.724740139327, 5006.0, 5021.322121513549, 5036.949630503795, 5052.065367906802, 3718.795466249274, 3721.7022638188337, 3727.1800203955086, 3728.161163738137, 3734.79458629778, 5116.5673611388875, 5357.1696387060065, 5417.404085550507, 5420.159875219348, 5438.728063596884, 5229.130443471728, 5240.593614150833, 5241.50205730455, 5247.868803279948, 5260.184671375943, 5217.738913179263, 5221.877296381296, 5239.611502951797, 5246.501582349671, 5254.660061684246, 4875.585575226146, 5146.485351464824, 5161.587073034223, 5181.896362072662, 5214.7914083436235, 5023.34696489454, 5073.11220536412, 5229.895402092013, 5268.552173065333, 5275.208718692227, 5108.208227724708, 5109.310243117132, 5117.2835802986865, 5124.077666020152, 5130.615203859651], "value": 3872.901742705233, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.5509771791694, 597.4473611908983, 601.3745704467351, 616.1312549305477, 634.6223996721949, 11033.613823516169, 11697.181197316191, 12086.274823510596, 12144.574939877095, 12178.81731774024, 12443.93778031111, 12601.62195134145, 12646.114771965944, 12658.746825063494, 12672.112952093357, 599.412575675838, 716.0941409117471, 733.9449541284398, 738.0737174845561, 738.65283316841, 719.4388377065897, 743.0563184755384, 749.5240522268344, 750.2984709296798, 754.1892465599475, 775.5695588948131, 779.5011192836589, 780.3718007004359, 786.5713186313473, 790.0558832195528, 775.1744392222294, 775.2557544757012, 780.9570473623949, 785.5836406704399, 786.5280831501111, 571.5341996273024, 574.471486232667, 575.3958343739057, 576.9394213607553, 577.2380457795712, 11075.16936229786, 11134.33194008362, 11141.832872506919, 11172.0, 11173.888261117367, 13117.672058198526, 13580.932095339558, 13793.517226897111, 13801.792973105412, 14064.859351406458, 9557.283203759745, 9660.420374777535, 9725.61097556104, 10036.89963100367, 10305.278630495868, 3184.50640150777, 3260.2664400509934, 3277.5083737439336, 3317.9027675680095, 3336.566246387954, 64029.35970640281, 65958.3404165957, 66448.0, 66735.0, 68404.0, 9777.706668799947, 9863.753406164904, 9908.108270255712, 9955.651552195639, 10095.091441770275, 20090.296839610543, 20133.697994530095, 20172.899135504227, 20175.697364539545, 20220.797792022186, 6560.606363618198, 6661.4004739573675, 6663.4669226461765, 6719.395254427027, 6721.731130754715, 3606.8376923038527, 3720.7023438124884, 3771.698264138862, 3791.696664266852, 3791.7914514701956, 2795.692473827877, 2894.0449651615336, 2899.2461959890156, 2902.680705122435, 2911.708829117071, 489.6694731056523, 492.5493173746054, 503.1471655543891, 509.8528311299576, 511.70065511676086, 481.8723038394828, 514.531776083762, 549.0693274899007, 567.6480582039079, 593.4006653280218, 7331.7638120373795, 7523.548587084792, 7530.548167109991, 7538.623068846536, 7753.418493613001, 485.6001265922959, 535.1357557544616, 536.6645846346033, 554.3680204566797, 564.4017341617898, 3496.877609283714, 3510.0, 3624.3113808376324, 3647.343478173901, 3672.3389789838084, 95187.52406237925, 95349.65104885322, 98996.0, 104645.0, 104817.0, 85515.57242213874, 88870.0, 90962.54518727497, 92723.0, 92811.53594231985, 46738.0, 47996.760016199696, 50041.499585004414, 61113.69443152756, 75064.80403957657, 6754.3921047106, 6803.387695107464, 6903.240643529308, 7040.647967601702, 7168.462365322517, 47733.5226647743, 47741.52258477371, 48464.0, 49372.55646991788, 49676.0, 38543.22913541769, 51602.48397516127, 53578.464215357344, 53802.73098634638, 59884.10173847483, 9837.409755414697, 9967.202623789934, 10231.386116833013, 10338.793224135625, 10342.638007669695, 11067.72330691739, 11471.197016208785, 11756.588519402121, 11767.941160294144, 11813.822792657946, 10278.794424111325, 10508.42203678805, 10546.894531054899, 10676.199285053808, 10787.406692631981, 10486.265961382935, 10539.15686745074, 10585.417802020655, 10783.0, 10856.457177140954, 10147.7463063424, 10374.481275936323, 10456.058954694114, 10519.579216831242, 10926.890731092906, 8300.169983001893, 8380.916190838014, 8440.409171358191, 8778.956105219433, 8950.68672596482, 8677.826443470969, 8728.301735861243, 9358.672446464341, 9392.624295028123, 9458.43249405038], "value": 6174.4451721567075, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 116.0, 114.0, 115.0, 115.0, 124.0, 116.0, 116.0, 135.0], "value": 117.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 123.0, 148.0, 192.0, 124.0, 158.0, 154.0, 127.0, 183.0, 129.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 165.0, 163.0, 163.0, 164.0, 165.0, 165.0, 167.0, 167.0, 164.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 170.0, 78.0, 77.0, 78.0, 77.0, 162.0, 78.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 131.0, 84.0, 85.0, 85.0, 136.0, 83.0, 84.0, 136.0], "value": 99.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 119.0, 119.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 147.0, 148.0, 148.0, 148.0, 150.0, 149.0, 150.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 66.0, 66.0, 68.0, 67.0, 66.0, 67.0, 69.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 70.0, 65.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 88.0, 83.0, 83.0, 83.0, 82.0, 88.0, 85.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 153.0, 143.0, 139.0, 143.0, 133.0, 133.0, 142.0, 180.0, 146.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 172.0, 175.0, 178.0, 178.0, 174.0, 172.0, 172.0, 177.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 72.0, 71.0, 72.0, 74.0, 74.0, 70.0, 69.0, 70.0], "value": 71.5, "unit": "score"}]}]} 13:07:55 INFO - Return code: 0 13:07:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:07:55 ERROR - # TBPL SUCCESS # 13:07:55 INFO - Running post-action listener: _resource_record_post_action 13:07:55 INFO - [mozharness: 2016-08-29 20:07:55.227704Z] Finished run-tests step (success) 13:07:55 INFO - Running post-run listener: _resource_record_post_run 13:07:55 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 416931840; Read time: 0; Write time: 295308 13:07:55 INFO - TinderboxPrint: CPU usage
13.4% 13:07:55 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:07:55 INFO - TinderboxPrint: I/O write bytes / time
416,931,840 / 295,308 13:07:55 INFO - TinderboxPrint: CPU idle
8,287.5 (86.6%) 13:07:55 INFO - TinderboxPrint: CPU user
1,220.1 (12.7%) 13:07:55 INFO - TinderboxPrint: Swap in / out
0 / 0 13:07:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124973056; Read time: 0; Write time: 84156 13:07:55 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 291401728; Read time: 0; Write time: 211144 13:07:55 INFO - Running post-run listener: _upload_blobber_files 13:07:55 INFO - Blob upload gear active. 13:07:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:07:55 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:07:55 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:07:55 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:07:56 INFO - (blobuploader) - INFO - Open directory for files ... 13:07:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:07:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:07:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:57 INFO - (blobuploader) - INFO - Done attempting. 13:07:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:07:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:07:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:57 INFO - (blobuploader) - INFO - Done attempting. 13:07:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:07:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:08:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:02 INFO - (blobuploader) - INFO - Done attempting. 13:08:02 INFO - (blobuploader) - INFO - Iteration through files over. 13:08:02 INFO - Return code: 0 13:08:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:08:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:08:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55d6add6640f8536c32b4adddcbb07a05b16a23c9c23091bcef6980edc3a77059d7a3015e03ae151171d5aaee7d030d3c865ab1a8ac97cf55e687534860338c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b9c80c2dffc9c7ea39b47e7e55f671ed4acfff9f8e21b320a29b68d8ad00ecd05ebe712db89a2da3399251c151bdb52162bd4e5c815322a891f725d575874ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d072c44f9d7c11ef5aa12779e46f430360798d7ad7cca257c316680440dc8752d2a320cb1b178af809c94d344c7b8b8829f09e0716b55917061befeded9561f7"} 13:08:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:08:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:08:02 INFO - Contents: 13:08:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55d6add6640f8536c32b4adddcbb07a05b16a23c9c23091bcef6980edc3a77059d7a3015e03ae151171d5aaee7d030d3c865ab1a8ac97cf55e687534860338c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b9c80c2dffc9c7ea39b47e7e55f671ed4acfff9f8e21b320a29b68d8ad00ecd05ebe712db89a2da3399251c151bdb52162bd4e5c815322a891f725d575874ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d072c44f9d7c11ef5aa12779e46f430360798d7ad7cca257c316680440dc8752d2a320cb1b178af809c94d344c7b8b8829f09e0716b55917061befeded9561f7"} 13:08:02 INFO - Running post-run listener: copy_logs_to_upload_dir 13:08:02 INFO - Copying logs to upload dir... 13:08:02 INFO - mkdir: /builds/slave/test/build/upload/logs 13:08:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.365214 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-29 13:08:01.456138) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 13:08:01.459470) ========= 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=db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517 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/55d6add6640f8536c32b4adddcbb07a05b16a23c9c23091bcef6980edc3a77059d7a3015e03ae151171d5aaee7d030d3c865ab1a8ac97cf55e687534860338c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b9c80c2dffc9c7ea39b47e7e55f671ed4acfff9f8e21b320a29b68d8ad00ecd05ebe712db89a2da3399251c151bdb52162bd4e5c815322a891f725d575874ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d072c44f9d7c11ef5aa12779e46f430360798d7ad7cca257c316680440dc8752d2a320cb1b178af809c94d344c7b8b8829f09e0716b55917061befeded9561f7"} build_url:https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/MerGhImURFSNsJPaqGwbDg/artifacts/public/build/firefox-51.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/55d6add6640f8536c32b4adddcbb07a05b16a23c9c23091bcef6980edc3a77059d7a3015e03ae151171d5aaee7d030d3c865ab1a8ac97cf55e687534860338c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b9c80c2dffc9c7ea39b47e7e55f671ed4acfff9f8e21b320a29b68d8ad00ecd05ebe712db89a2da3399251c151bdb52162bd4e5c815322a891f725d575874ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d072c44f9d7c11ef5aa12779e46f430360798d7ad7cca257c316680440dc8752d2a320cb1b178af809c94d344c7b8b8829f09e0716b55917061befeded9561f7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 13:08:01.485428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:08:01.485729) ========= 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=db7e7c15f3ca076d53731445000001ba-1472498823.994972-502578517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:08:01.570221) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 13:08:01.570536) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 13:08:01.570853) ========= ========= Total master_lag: 0.19 =========