builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1470632724.5 results: success (0) buildid: 20160807203752 builduid: feb9cca50f40462fbc7f68e999dac6b6 revision: e47457d354ec288f0fd54d2b44602d0e3c28bce3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:24.501181) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:24.501695) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:24.501978) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:24.529111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:24.529451) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1470631035.477024-729702597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 22:05:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 495K=0.02s 2016-08-07 22:05:25 (495 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145643 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:24.701385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:24.701667) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1470631035.477024-729702597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020359 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:24.754528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:24.754916) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e47457d354ec288f0fd54d2b44602d0e3c28bce3 --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 e47457d354ec288f0fd54d2b44602d0e3c28bce3 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1470631035.477024-729702597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 22:05:25,789 truncating revision to first 12 chars 2016-08-07 22:05:25,790 Setting DEBUG logging. 2016-08-07 22:05:25,790 attempt 1/10 2016-08-07 22:05:25,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e47457d354ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 22:05:26,104 unpacking tar archive at: autoland-e47457d354ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:25.462226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:25.462495) ========= script_repo_revision: e47457d354ec288f0fd54d2b44602d0e3c28bce3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:25.462866) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:25.463165) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 22:05:25.473925) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-07 22:05:25.474187) ========= /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=745a4373a2a16df560f216e000000264-1470631035.477024-729702597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:05:26 INFO - MultiFileLogger online at 20160807 22:05:26 in /builds/slave/test 22:05:26 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 22:05:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:05:26 INFO - {'append_to_log': False, 22:05:26 INFO - 'base_work_dir': '/builds/slave/test', 22:05:26 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 22:05:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:05:26 INFO - 'branch': 'Autoland-Non-PGO', 22:05:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:05:26 INFO - 'config_files': ('talos/linux_config.py',), 22:05:26 INFO - 'default_actions': ('clobber', 22:05:26 INFO - 'read-buildbot-config', 22:05:26 INFO - 'download-and-extract', 22:05:26 INFO - 'populate-webroot', 22:05:26 INFO - 'create-virtualenv', 22:05:26 INFO - 'install', 22:05:26 INFO - 'run-tests'), 22:05:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:05:26 INFO - 'download_minidump_stackwalk': True, 22:05:26 INFO - 'download_symbols': 'ondemand', 22:05:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:05:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:05:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:05:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:05:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:05:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:05:26 INFO - 'installer_path': 'installer.exe', 22:05:26 INFO - 'log_level': 'info', 22:05:26 INFO - 'log_name': 'talos', 22:05:26 INFO - 'log_to_console': True, 22:05:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:05:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:05:26 INFO - 'opt_config_files': (), 22:05:26 INFO - 'pip_index': False, 22:05:26 INFO - 'sps_profile': False, 22:05:26 INFO - 'sps_profile_interval': 0, 22:05:26 INFO - 'suite': 'dromaeojs-e10s', 22:05:26 INFO - 'system_bits': '32', 22:05:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:05:26 INFO - 'title': 'talos-linux64-ix-032', 22:05:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:05:26 INFO - 'use_talos_json': True, 22:05:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:05:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:05:26 INFO - 'work_dir': 'build'} 22:05:26 INFO - [mozharness: 2016-08-08 05:05:26.600547Z] Running clobber step. 22:05:26 INFO - Running pre-action listener: _resource_record_pre_action 22:05:26 INFO - Running main action method: clobber 22:05:26 INFO - rmtree: /builds/slave/test/build 22:05:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:05:27 INFO - Running post-action listener: _resource_record_post_action 22:05:27 INFO - [mozharness: 2016-08-08 05:05:27.063093Z] Finished clobber step (success) 22:05:27 INFO - [mozharness: 2016-08-08 05:05:27.063194Z] Running read-buildbot-config step. 22:05:27 INFO - Running pre-action listener: _resource_record_pre_action 22:05:27 INFO - Running main action method: read_buildbot_config 22:05:27 INFO - Using buildbot properties: 22:05:27 INFO - { 22:05:27 INFO - "project": "", 22:05:27 INFO - "product": "firefox", 22:05:27 INFO - "script_repo_revision": "production", 22:05:27 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 22:05:27 INFO - "repository": "", 22:05:27 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 22:05:27 INFO - "buildid": "20160807203752", 22:05:27 INFO - "pgo_build": "False", 22:05:27 INFO - "basedir": "/builds/slave/test", 22:05:27 INFO - "buildnumber": 236, 22:05:27 INFO - "slavename": "talos-linux64-ix-032", 22:05:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:05:27 INFO - "platform": "ubuntu64_hw", 22:05:27 INFO - "scheduler": "tests-autoland-linux64-talos", 22:05:27 INFO - "branch": "autoland", 22:05:27 INFO - "repo_path": "integration/autoland", 22:05:27 INFO - "revision": "e47457d354ec288f0fd54d2b44602d0e3c28bce3", 22:05:27 INFO - "stage_platform": "linux64", 22:05:27 INFO - "builduid": "feb9cca50f40462fbc7f68e999dac6b6", 22:05:27 INFO - "slavebuilddir": "test" 22:05:27 INFO - } 22:05:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 22:05:27 INFO - Running post-action listener: _resource_record_post_action 22:05:27 INFO - [mozharness: 2016-08-08 05:05:27.066022Z] Finished read-buildbot-config step (success) 22:05:27 INFO - [mozharness: 2016-08-08 05:05:27.066111Z] Running download-and-extract step. 22:05:27 INFO - Running pre-action listener: _resource_record_pre_action 22:05:27 INFO - Running main action method: download_and_extract 22:05:27 INFO - mkdir: /builds/slave/test/build/tests 22:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:27 INFO - trying https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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 22:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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 22:05:27 INFO - Downloaded 1361 bytes. 22:05:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:05:27 INFO - Using the following test package requirements: 22:05:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:05:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:05:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:05:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:27 INFO - u'jsshell-linux-x86_64.zip'], 22:05:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:05:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:05:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:05:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:05:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:05:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:05:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:27 INFO - trying https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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 22:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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 22:05:28 INFO - Downloaded 20257815 bytes. 22:05:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:05:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:05:29 INFO - Return code: 0 22:05:29 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 22:05: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')]} 22:05:29 INFO - trying https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:05:29 INFO - Downloading https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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 22:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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 22:05:30 INFO - Downloaded 20257815 bytes. 22:05:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:05:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:05:32 INFO - Return code: 0 22:05:32 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')]} 22:05:32 INFO - trying https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:05:32 INFO - Downloading https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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 22:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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 22:05:33 INFO - Downloaded 14413723 bytes. 22:05:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:05:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:05:33 INFO - Return code: 0 22:05:33 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')]} 22:05:33 INFO - trying https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:05:33 INFO - Downloading https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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 22:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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 22:05:35 INFO - Downloaded 56140767 bytes. 22:05:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:05:35 INFO - mkdir: /builds/slave/test/properties 22:05:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:05:35 INFO - Writing to file /builds/slave/test/properties/build_url 22:05:35 INFO - Contents: 22:05:35 INFO - build_url:https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:05:35 INFO - Running post-action listener: _resource_record_post_action 22:05:35 INFO - Running post-action listener: set_extra_try_arguments 22:05:35 INFO - [mozharness: 2016-08-08 05:05:35.645715Z] Finished download-and-extract step (success) 22:05:35 INFO - [mozharness: 2016-08-08 05:05:35.646040Z] Running populate-webroot step. 22:05:35 INFO - Running pre-action listener: _resource_record_pre_action 22:05:35 INFO - Running main action method: populate_webroot 22:05:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:05:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:05:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:05:35 INFO - '--tppagecycles', 22:05:35 INFO - '7'], 22:05:35 INFO - 'tests': ['tsvgm']}}, 22:05:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:05:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:05:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:05:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:05:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:35 INFO - 'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:05:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:05:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:35 INFO - 'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['damp', 'tps']}, 22:05:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:35 INFO - 'tests': ['damp', 'tps']}, 22:05:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['dromaeo_dom']}, 22:05:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:05:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['basic_compositor_video']}, 22:05:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:05:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['a11yr', 22:05:35 INFO - 'ts_paint', 22:05:35 INFO - 'tpaint', 22:05:35 INFO - 'sessionrestore', 22:05:35 INFO - 'sessionrestore_no_auto_restore', 22:05:35 INFO - 'tabpaint']}, 22:05:35 INFO - 'other-e10s': {'tests': ['a11yr', 22:05:35 INFO - 'ts_paint', 22:05:35 INFO - 'tpaint', 22:05:35 INFO - 'sessionrestore', 22:05:35 INFO - 'sessionrestore_no_auto_restore', 22:05:35 INFO - 'tabpaint']}, 22:05:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:05:35 INFO - 'ts_paint', 22:05:35 INFO - 'tpaint', 22:05:35 INFO - 'sessionrestore', 22:05:35 INFO - 'sessionrestore_no_auto_restore', 22:05:35 INFO - 'tabpaint']}, 22:05:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:05:35 INFO - 'ts_paint', 22:05:35 INFO - 'tpaint', 22:05:35 INFO - 'sessionrestore', 22:05:35 INFO - 'sessionrestore_no_auto_restore', 22:05:35 INFO - 'tabpaint']}, 22:05:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['a11yr', 22:05:35 INFO - 'ts_paint', 22:05:35 INFO - 'tpaint', 22:05:35 INFO - 'sessionrestore', 22:05:35 INFO - 'sessionrestore_no_auto_restore', 22:05:35 INFO - 'tabpaint']}, 22:05:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['a11yr', 22:05:35 INFO - 'ts_paint', 22:05:35 INFO - 'tpaint', 22:05:35 INFO - 'sessionrestore', 22:05:35 INFO - 'sessionrestore_no_auto_restore', 22:05:35 INFO - 'tabpaint']}, 22:05:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['tsvgx', 22:05:35 INFO - 'tsvgr_opacity', 22:05:35 INFO - 'tart', 22:05:35 INFO - 'tscrollx', 22:05:35 INFO - 'cart']}, 22:05:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:05:35 INFO - 'tsvgr_opacity', 22:05:35 INFO - 'tart', 22:05:35 INFO - 'tscrollx', 22:05:35 INFO - 'cart']}, 22:05:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:35 INFO - 'talos_options': ['--disable-e10s'], 22:05:35 INFO - 'tests': ['tp5o']}, 22:05:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:35 INFO - 'tests': ['tp5o']}, 22:05:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:35 INFO - 'talos_options': ['--disable-e10s', 22:05:35 INFO - '--xperf_path', 22:05:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:05:35 INFO - 'tests': ['tp5n']}, 22:05:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:35 INFO - 'talos_options': ['--xperf_path', 22:05:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:05:35 INFO - 'tests': ['tp5n']}}, 22:05:35 INFO - 'talos.zip': {'path': '', 22:05:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:05:35 INFO - Running post-action listener: _resource_record_post_action 22:05:35 INFO - [mozharness: 2016-08-08 05:05:35.664803Z] Finished populate-webroot step (success) 22:05:35 INFO - [mozharness: 2016-08-08 05:05:35.664892Z] Running create-virtualenv step. 22:05:35 INFO - Running pre-action listener: _resource_record_pre_action 22:05:35 INFO - Running main action method: create_virtualenv 22:05:35 INFO - Creating virtualenv /builds/slave/test/build/venv 22:05:35 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 22:05:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:05:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:05:35 INFO - Using real prefix '/usr' 22:05:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:05:36 INFO - Installing distribute.............................................................................................................................................................................................done. 22:05:38 INFO - Installing pip.................done. 22:05:38 INFO - Return code: 0 22:05:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:38 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 0x1830030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', '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 22:05:38 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 22:05:38 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 22:05:38 INFO - Using env: {'DISPLAY': ':0', 22:05:38 INFO - 'HOME': '/home/cltbld', 22:05:38 INFO - 'LANG': 'en_US.UTF-8', 22:05:38 INFO - 'LANGUAGE': 'en_US:en', 22:05:38 INFO - 'LOGNAME': 'cltbld', 22:05:38 INFO - 'MAIL': '/var/mail/cltbld', 22:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:38 INFO - 'MOZ_NO_REMOTE': '1', 22:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:38 INFO - 'NO_EM_RESTART': '1', 22:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:38 INFO - 'PWD': '/builds/slave/test', 22:05:38 INFO - 'SHELL': '/bin/bash', 22:05:38 INFO - 'SHLVL': '1', 22:05:38 INFO - 'TERM': 'linux', 22:05:38 INFO - 'TMOUT': '86400', 22:05:38 INFO - 'USER': 'cltbld', 22:05:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:38 INFO - '_': '/tools/buildbot/bin/python'} 22:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:38 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 22:05:38 INFO - Cleaning up... 22:05:38 INFO - Return code: 0 22:05:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:38 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 0x1830030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', '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 22:05:38 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 22:05:38 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 22:05:38 INFO - Using env: {'DISPLAY': ':0', 22:05:38 INFO - 'HOME': '/home/cltbld', 22:05:38 INFO - 'LANG': 'en_US.UTF-8', 22:05:38 INFO - 'LANGUAGE': 'en_US:en', 22:05:38 INFO - 'LOGNAME': 'cltbld', 22:05:38 INFO - 'MAIL': '/var/mail/cltbld', 22:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:38 INFO - 'MOZ_NO_REMOTE': '1', 22:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:38 INFO - 'NO_EM_RESTART': '1', 22:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:38 INFO - 'PWD': '/builds/slave/test', 22:05:38 INFO - 'SHELL': '/bin/bash', 22:05:38 INFO - 'SHLVL': '1', 22:05:38 INFO - 'TERM': 'linux', 22:05:38 INFO - 'TMOUT': '86400', 22:05:38 INFO - 'USER': 'cltbld', 22:05:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:38 INFO - '_': '/tools/buildbot/bin/python'} 22:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:38 INFO - Downloading/unpacking psutil>=3.1.1 22:05:38 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 22:05:38 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 22:05:38 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 22:05:38 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 22:05:38 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 22:05:38 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 22:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:05:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:05:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:05:40 INFO - Installing collected packages: psutil 22:05:40 INFO - Running setup.py install for psutil 22:05:40 INFO - building 'psutil._psutil_linux' extension 22:05:40 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 22:05:41 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 22:05:41 INFO - building 'psutil._psutil_posix' extension 22:05:41 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 22:05:41 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 22:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:05:41 INFO - Successfully installed psutil 22:05:41 INFO - Cleaning up... 22:05:41 INFO - Return code: 0 22:05:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1830030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', '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 22:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:05:41 INFO - Using env: {'DISPLAY': ':0', 22:05:41 INFO - 'HOME': '/home/cltbld', 22:05:41 INFO - 'LANG': 'en_US.UTF-8', 22:05:41 INFO - 'LANGUAGE': 'en_US:en', 22:05:41 INFO - 'LOGNAME': 'cltbld', 22:05:41 INFO - 'MAIL': '/var/mail/cltbld', 22:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:41 INFO - 'MOZ_NO_REMOTE': '1', 22:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:41 INFO - 'NO_EM_RESTART': '1', 22:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:41 INFO - 'PWD': '/builds/slave/test', 22:05:41 INFO - 'SHELL': '/bin/bash', 22:05:41 INFO - 'SHLVL': '1', 22:05:41 INFO - 'TERM': 'linux', 22:05:41 INFO - 'TMOUT': '86400', 22:05:41 INFO - 'USER': 'cltbld', 22:05:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:41 INFO - '_': '/tools/buildbot/bin/python'} 22:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:05:43 INFO - Installing collected packages: mozsystemmonitor 22:05:43 INFO - Running setup.py install for mozsystemmonitor 22:05:43 INFO - Successfully installed mozsystemmonitor 22:05:43 INFO - Cleaning up... 22:05:43 INFO - Return code: 0 22:05:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:05: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')]} 22:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05: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')]} 22:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05: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', '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 0x1830030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', '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 22:05: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:05: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 jsonschema==2.5.1 22:05:43 INFO - Using env: {'DISPLAY': ':0', 22:05:43 INFO - 'HOME': '/home/cltbld', 22:05:43 INFO - 'LANG': 'en_US.UTF-8', 22:05:43 INFO - 'LANGUAGE': 'en_US:en', 22:05:43 INFO - 'LOGNAME': 'cltbld', 22:05:43 INFO - 'MAIL': '/var/mail/cltbld', 22:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:43 INFO - 'MOZ_NO_REMOTE': '1', 22:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:43 INFO - 'NO_EM_RESTART': '1', 22:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:43 INFO - 'PWD': '/builds/slave/test', 22:05:43 INFO - 'SHELL': '/bin/bash', 22:05:43 INFO - 'SHLVL': '1', 22:05:43 INFO - 'TERM': 'linux', 22:05:43 INFO - 'TMOUT': '86400', 22:05:43 INFO - 'USER': 'cltbld', 22:05:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:43 INFO - '_': '/tools/buildbot/bin/python'} 22:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:43 INFO - Downloading/unpacking jsonschema==2.5.1 22:05: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 22:05: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 22:05: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 22:05: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 22:05: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 22:05: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 22:05:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:05:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:05: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 22:05: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 22:05: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 22:05: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 22:05: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 22:05: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 22:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 22:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:05:46 INFO - warning: no files found matching '*.txt' 22:05:46 INFO - no previously-included directories found matching 'build' 22:05:46 INFO - no previously-included directories found matching 'dist' 22:05:46 INFO - no previously-included directories found matching '.git*' 22:05:46 INFO - Installing collected packages: jsonschema, functools32 22:05:46 INFO - Running setup.py install for functools32 22:05:46 INFO - warning: no files found matching '*.txt' 22:05:46 INFO - no previously-included directories found matching 'build' 22:05:46 INFO - no previously-included directories found matching 'dist' 22:05:46 INFO - no previously-included directories found matching '.git*' 22:05:46 INFO - Successfully installed jsonschema functools32 22:05:46 INFO - Cleaning up... 22:05:46 INFO - Return code: 0 22:05:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:05: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')]} 22:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05: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')]} 22:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1830030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', '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 22:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:05:46 INFO - Using env: {'DISPLAY': ':0', 22:05:46 INFO - 'HOME': '/home/cltbld', 22:05:46 INFO - 'LANG': 'en_US.UTF-8', 22:05:46 INFO - 'LANGUAGE': 'en_US:en', 22:05:46 INFO - 'LOGNAME': 'cltbld', 22:05:46 INFO - 'MAIL': '/var/mail/cltbld', 22:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:46 INFO - 'MOZ_NO_REMOTE': '1', 22:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:46 INFO - 'NO_EM_RESTART': '1', 22:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:46 INFO - 'PWD': '/builds/slave/test', 22:05:46 INFO - 'SHELL': '/bin/bash', 22:05:46 INFO - 'SHLVL': '1', 22:05:46 INFO - 'TERM': 'linux', 22:05:46 INFO - 'TMOUT': '86400', 22:05:46 INFO - 'USER': 'cltbld', 22:05:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:46 INFO - '_': '/tools/buildbot/bin/python'} 22:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:05:46 INFO - Cleaning up... 22:05:46 INFO - Return code: 0 22:05:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:05: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')]} 22:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05: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')]} 22:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1830030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', '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 22:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:05:46 INFO - Using env: {'DISPLAY': ':0', 22:05:46 INFO - 'HOME': '/home/cltbld', 22:05:46 INFO - 'LANG': 'en_US.UTF-8', 22:05:46 INFO - 'LANGUAGE': 'en_US:en', 22:05:46 INFO - 'LOGNAME': 'cltbld', 22:05:46 INFO - 'MAIL': '/var/mail/cltbld', 22:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:46 INFO - 'MOZ_NO_REMOTE': '1', 22:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:46 INFO - 'NO_EM_RESTART': '1', 22:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:46 INFO - 'PWD': '/builds/slave/test', 22:05:46 INFO - 'SHELL': '/bin/bash', 22:05:46 INFO - 'SHLVL': '1', 22:05:46 INFO - 'TERM': 'linux', 22:05:46 INFO - 'TMOUT': '86400', 22:05:46 INFO - 'USER': 'cltbld', 22:05:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:46 INFO - '_': '/tools/buildbot/bin/python'} 22:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:46 INFO - Downloading/unpacking blobuploader==1.2.4 22:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:48 INFO - Downloading blobuploader-1.2.4.tar.gz 22:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:05:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:05:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:49 INFO - Downloading docopt-0.6.1.tar.gz 22:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:05:49 INFO - Installing collected packages: blobuploader, requests, docopt 22:05:49 INFO - Running setup.py install for blobuploader 22:05:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:05:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:05:49 INFO - Running setup.py install for requests 22:05:49 INFO - Running setup.py install for docopt 22:05:49 INFO - Successfully installed blobuploader requests docopt 22:05:49 INFO - Cleaning up... 22:05:49 INFO - Return code: 0 22:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:05: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')]} 22:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05: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')]} 22:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:49 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 0x1830030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', '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 22:05:49 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 22:05:49 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 22:05:49 INFO - Using env: {'DISPLAY': ':0', 22:05:49 INFO - 'HOME': '/home/cltbld', 22:05:49 INFO - 'LANG': 'en_US.UTF-8', 22:05:49 INFO - 'LANGUAGE': 'en_US:en', 22:05:49 INFO - 'LOGNAME': 'cltbld', 22:05:49 INFO - 'MAIL': '/var/mail/cltbld', 22:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:49 INFO - 'MOZ_NO_REMOTE': '1', 22:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:49 INFO - 'NO_EM_RESTART': '1', 22:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:49 INFO - 'PWD': '/builds/slave/test', 22:05:49 INFO - 'SHELL': '/bin/bash', 22:05:49 INFO - 'SHLVL': '1', 22:05:49 INFO - 'TERM': 'linux', 22:05:49 INFO - 'TMOUT': '86400', 22:05:49 INFO - 'USER': 'cltbld', 22:05:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:49 INFO - '_': '/tools/buildbot/bin/python'} 22:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:05:50 INFO - Running setup.py (path:/tmp/pip-YpbaXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:05:50 INFO - Running setup.py (path:/tmp/pip-TJfqZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:05:50 INFO - Running setup.py (path:/tmp/pip-CAIw5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:05:50 INFO - Running setup.py (path:/tmp/pip-_Qwz1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:05:50 INFO - Running setup.py (path:/tmp/pip-rg3ZlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:05:50 INFO - Running setup.py (path:/tmp/pip-7XQpCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:05:50 INFO - Running setup.py (path:/tmp/pip-ej97PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:05:50 INFO - Running setup.py (path:/tmp/pip-aMnoTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:05:50 INFO - Running setup.py (path:/tmp/pip-KZZ0W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:05:50 INFO - Running setup.py (path:/tmp/pip-uq5ATX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:05:50 INFO - Running setup.py (path:/tmp/pip-76uEx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:05:50 INFO - Running setup.py (path:/tmp/pip-89m2Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:05:51 INFO - Running setup.py (path:/tmp/pip-9iGXDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:05:51 INFO - Running setup.py (path:/tmp/pip-IrEDOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:05:51 INFO - Running setup.py (path:/tmp/pip-bS9SmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:05:51 INFO - Running setup.py (path:/tmp/pip-A7IRH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:05:51 INFO - Running setup.py (path:/tmp/pip-aKkuUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:05:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:05:51 INFO - Running setup.py install for manifestparser 22:05:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:05:51 INFO - Running setup.py install for mozcrash 22:05:51 INFO - Running setup.py install for mozdebug 22:05:51 INFO - Running setup.py install for mozdevice 22:05:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:05:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:05:51 INFO - Running setup.py install for mozfile 22:05:51 INFO - Running setup.py install for mozhttpd 22:05:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Running setup.py install for mozinfo 22:05:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Running setup.py install for mozInstall 22:05:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Running setup.py install for mozleak 22:05:52 INFO - Running setup.py install for mozlog 22:05:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Running setup.py install for moznetwork 22:05:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Running setup.py install for mozprocess 22:05:52 INFO - Running setup.py install for mozprofile 22:05:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Running setup.py install for mozrunner 22:05:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:05:52 INFO - Running setup.py install for mozscreenshot 22:05:52 INFO - Running setup.py install for moztest 22:05:53 INFO - Running setup.py install for mozversion 22:05:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:05:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:05:53 INFO - Cleaning up... 22:05:53 INFO - Return code: 0 22:05:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:05: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')]} 22:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05: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')]} 22:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:53 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 0x1830030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', '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 22:05:53 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 22:05:53 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 22:05:53 INFO - Using env: {'DISPLAY': ':0', 22:05:53 INFO - 'HOME': '/home/cltbld', 22:05:53 INFO - 'LANG': 'en_US.UTF-8', 22:05:53 INFO - 'LANGUAGE': 'en_US:en', 22:05:53 INFO - 'LOGNAME': 'cltbld', 22:05:53 INFO - 'MAIL': '/var/mail/cltbld', 22:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:53 INFO - 'MOZ_NO_REMOTE': '1', 22:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:53 INFO - 'NO_EM_RESTART': '1', 22:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:53 INFO - 'PWD': '/builds/slave/test', 22:05:53 INFO - 'SHELL': '/bin/bash', 22:05:53 INFO - 'SHLVL': '1', 22:05:53 INFO - 'TERM': 'linux', 22:05:53 INFO - 'TMOUT': '86400', 22:05:53 INFO - 'USER': 'cltbld', 22:05:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:53 INFO - '_': '/tools/buildbot/bin/python'} 22:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:05:53 INFO - Running setup.py (path:/tmp/pip-7vYLNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:05:53 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)) 22:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:05:53 INFO - Running setup.py (path:/tmp/pip-umSCP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:05:53 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)) 22:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:05:53 INFO - Running setup.py (path:/tmp/pip-UKVBAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:05:53 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)) 22:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:05:53 INFO - Running setup.py (path:/tmp/pip-uq8P6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:05:53 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)) 22:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:05:53 INFO - Running setup.py (path:/tmp/pip-DWz9BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:05:53 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)) 22:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:05:53 INFO - Running setup.py (path:/tmp/pip-cKIROK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:05:53 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)) 22:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:05:53 INFO - Running setup.py (path:/tmp/pip-abTZZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:05:53 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)) 22:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:05:53 INFO - Running setup.py (path:/tmp/pip-MBNbVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:05:53 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)) 22:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:05:53 INFO - Running setup.py (path:/tmp/pip-89Jka9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:05:54 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)) 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:05:54 INFO - Running setup.py (path:/tmp/pip-pS_9tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:05:54 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)) 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:05:54 INFO - Running setup.py (path:/tmp/pip-kSsMDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:05:54 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)) 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:05:54 INFO - Running setup.py (path:/tmp/pip-BdzS6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:05:54 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)) 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:05:54 INFO - Running setup.py (path:/tmp/pip-_73NTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:05:54 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)) 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:05:54 INFO - Running setup.py (path:/tmp/pip-XxBqpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:05:54 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)) 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:05:54 INFO - Running setup.py (path:/tmp/pip-A4VjP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:05:54 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)) 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:05:54 INFO - Running setup.py (path:/tmp/pip-v9EcZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:05:54 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)) 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:05:54 INFO - Running setup.py (path:/tmp/pip-udKQeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:05:54 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)) 22:05:54 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)) 22:05:54 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)) 22:05:54 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)) 22:05:54 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)) 22:05:54 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)) 22:05:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:56 INFO - Downloading blessings-1.6.tar.gz 22:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:05:56 INFO - Installing collected packages: blessings 22:05:56 INFO - Running setup.py install for blessings 22:05:56 INFO - Successfully installed blessings 22:05:56 INFO - Cleaning up... 22:05:56 INFO - Return code: 0 22:05:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:05:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:05:56 INFO - Reading from file tmpfile_stdout 22:05:56 INFO - Current package versions: 22:05:56 INFO - argparse == 1.2.1 22:05:56 INFO - blessings == 1.6 22:05:56 INFO - blobuploader == 1.2.4 22:05:56 INFO - docopt == 0.6.1 22:05:56 INFO - functools32 == 3.2.3-2 22:05:56 INFO - jsonschema == 2.5.1 22:05:56 INFO - manifestparser == 1.1 22:05:56 INFO - mozInstall == 1.12 22:05:56 INFO - mozcrash == 0.17 22:05:56 INFO - mozdebug == 0.1 22:05:56 INFO - mozdevice == 0.48 22:05:56 INFO - mozfile == 1.2 22:05:56 INFO - mozhttpd == 0.7 22:05:56 INFO - mozinfo == 0.9 22:05:56 INFO - mozleak == 0.1 22:05:56 INFO - mozlog == 3.3 22:05:56 INFO - moznetwork == 0.27 22:05:56 INFO - mozprocess == 0.23 22:05:56 INFO - mozprofile == 0.28 22:05:56 INFO - mozrunner == 6.12 22:05:56 INFO - mozscreenshot == 0.1 22:05:56 INFO - mozsystemmonitor == 0.3 22:05:56 INFO - moztest == 0.7 22:05:56 INFO - mozversion == 1.4 22:05:56 INFO - psutil == 3.1.1 22:05:56 INFO - requests == 1.2.3 22:05:56 INFO - wsgiref == 0.1.2 22:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:56 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 0x1830030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', '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 22:05:56 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 22:05:56 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 22:05:56 INFO - Using env: {'DISPLAY': ':0', 22:05:56 INFO - 'HOME': '/home/cltbld', 22:05:56 INFO - 'LANG': 'en_US.UTF-8', 22:05:56 INFO - 'LANGUAGE': 'en_US:en', 22:05:56 INFO - 'LOGNAME': 'cltbld', 22:05:56 INFO - 'MAIL': '/var/mail/cltbld', 22:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:56 INFO - 'MOZ_NO_REMOTE': '1', 22:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:56 INFO - 'NO_EM_RESTART': '1', 22:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:56 INFO - 'PWD': '/builds/slave/test', 22:05:56 INFO - 'SHELL': '/bin/bash', 22:05:56 INFO - 'SHLVL': '1', 22:05:56 INFO - 'TERM': 'linux', 22:05:56 INFO - 'TMOUT': '86400', 22:05:56 INFO - 'USER': 'cltbld', 22:05:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:56 INFO - '_': '/tools/buildbot/bin/python'} 22:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:57 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)) 22:05:57 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)) 22:05:57 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)) 22:05:57 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)) 22:05:57 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)) 22:05:57 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)) 22:05:57 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)) 22:05:57 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)) 22:05:57 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)) 22:05:57 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)) 22:05:57 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)) 22:05:57 INFO - Cleaning up... 22:05:57 INFO - Return code: 0 22:05:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:05:57 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')]} 22:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:57 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')]} 22:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:57 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 0x1830030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', '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 22:05:57 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 22:05:57 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 22:05:57 INFO - Using env: {'DISPLAY': ':0', 22:05:57 INFO - 'HOME': '/home/cltbld', 22:05:57 INFO - 'LANG': 'en_US.UTF-8', 22:05:57 INFO - 'LANGUAGE': 'en_US:en', 22:05:57 INFO - 'LOGNAME': 'cltbld', 22:05:57 INFO - 'MAIL': '/var/mail/cltbld', 22:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:57 INFO - 'MOZ_NO_REMOTE': '1', 22:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:57 INFO - 'NO_EM_RESTART': '1', 22:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:57 INFO - 'PWD': '/builds/slave/test', 22:05:57 INFO - 'SHELL': '/bin/bash', 22:05:57 INFO - 'SHLVL': '1', 22:05:57 INFO - 'TERM': 'linux', 22:05:57 INFO - 'TMOUT': '86400', 22:05:57 INFO - 'USER': 'cltbld', 22:05:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:57 INFO - '_': '/tools/buildbot/bin/python'} 22:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:05:57 INFO - Cleaning up... 22:05:57 INFO - Return code: 0 22:05:57 INFO - Running post-action listener: _resource_record_post_action 22:05:57 INFO - Running post-action listener: _start_resource_monitoring 22:05:57 INFO - Starting resource monitoring. 22:05:57 INFO - [mozharness: 2016-08-08 05:05:57.446390Z] Finished create-virtualenv step (success) 22:05:57 INFO - [mozharness: 2016-08-08 05:05:57.446866Z] Running install step. 22:05:57 INFO - Running pre-action listener: _resource_record_pre_action 22:05:57 INFO - Running main action method: install 22:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:05:57 INFO - Reading from file tmpfile_stdout 22:05:57 INFO - Detecting whether we're running mozinstall >=1.0... 22:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:05:57 INFO - Reading from file tmpfile_stdout 22:05:57 INFO - Output received: 22:05:57 INFO - Usage: mozinstall [options] installer 22:05:57 INFO - Options: 22:05:57 INFO - -h, --help show this help message and exit 22:05:57 INFO - -d DEST, --destination=DEST 22:05:57 INFO - Directory to install application into. [default: 22:05:57 INFO - "/builds/slave/test"] 22:05:57 INFO - --app=APP Application being installed. [default: firefox] 22:05:57 INFO - mkdir: /builds/slave/test/build/application 22:05:57 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'] 22:05:57 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 22:06:15 INFO - Reading from file tmpfile_stdout 22:06:15 INFO - Output received: 22:06:15 INFO - /builds/slave/test/build/application/firefox/firefox 22:06:15 INFO - Running post-action listener: _resource_record_post_action 22:06:15 INFO - [mozharness: 2016-08-08 05:06:15.028214Z] Finished install step (success) 22:06:15 INFO - [mozharness: 2016-08-08 05:06:15.028461Z] Running run-tests step. 22:06:15 INFO - Running pre-action listener: _resource_record_pre_action 22:06:15 INFO - Running main action method: run_tests 22:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:06:15 INFO - Python 2.7.3 22:06:15 INFO - Return code: 0 22:06:15 INFO - grabbing minidump binary from tooltool 22:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:06:15 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 0x1aee570>, '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 0x1aef470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:06:15 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 22:06:15 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 22:06:15 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 22:06:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:06:15 INFO - Return code: 0 22:06:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:06:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:06:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:06:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:06:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:06:15 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/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:06:15 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/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:06:15 INFO - Using env: {'DISPLAY': ':0', 22:06:15 INFO - 'HOME': '/home/cltbld', 22:06:15 INFO - 'LANG': 'en_US.UTF-8', 22:06:15 INFO - 'LANGUAGE': 'en_US:en', 22:06:15 INFO - 'LOGNAME': 'cltbld', 22:06:15 INFO - 'MAIL': '/var/mail/cltbld', 22:06:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:06:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:15 INFO - 'MOZ_NO_REMOTE': '1', 22:06:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:15 INFO - 'NO_EM_RESTART': '1', 22:06:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:15 INFO - 'PWD': '/builds/slave/test', 22:06:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:06:15 INFO - 'SHELL': '/bin/bash', 22:06:15 INFO - 'SHLVL': '1', 22:06:15 INFO - 'TERM': 'linux', 22:06:15 INFO - 'TMOUT': '86400', 22:06:15 INFO - 'USER': 'cltbld', 22:06:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470631035.477024-729702597', 22:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:15 INFO - '_': '/tools/buildbot/bin/python'} 22:06:15 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/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:06:15 INFO - mozversion application_buildid: 20160807203752 22:06:15 INFO - mozversion application_changeset: e47457d354ec288f0fd54d2b44602d0e3c28bce3 22:06:15 INFO - mozversion application_display_name: Nightly 22:06:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:06:15 INFO - mozversion application_name: Firefox 22:06:15 INFO - mozversion application_remotingname: firefox 22:06:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:06:15 INFO - mozversion application_vendor: Mozilla 22:06:15 INFO - mozversion application_version: 51.0a1 22:06:15 INFO - mozversion platform_buildid: 20160807203752 22:06:15 INFO - mozversion platform_changeset: e47457d354ec288f0fd54d2b44602d0e3c28bce3 22:06:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:06:15 INFO - mozversion platform_version: 51.0a1 22:06:15 INFO - using testdate: 1470632775 22:06:15 INFO - actual date: 1470632775 22:06:15 INFO - starting webserver on 'localhost:45771' 22:06:15 INFO - SUITE-START | Running 2 tests 22:06:15 INFO - TEST-START | dromaeo_css 22:06:15 INFO - operating with platform_type : linux_ 22:06:15 INFO - Initialising browser for dromaeo_css test... 22:06:15 INFO - TEST-INFO | started process 3893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkuBskp/profile http://localhost:45771/getInfo.html) 22:06:20 INFO - PROCESS | 3893 | __metrics Screen width/height:1600/1200 22:06:20 INFO - PROCESS | 3893 | colorDepth:24 22:06:20 INFO - PROCESS | 3893 | Browser inner width/height: 1024/697 22:06:20 INFO - PROCESS | 3893 | __metrics 22:06:21 ERROR - PROCESS | 3893 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:06:22 INFO - TEST-INFO | 3893: exit 0 22:06:22 INFO - Browser initialized. 22:06:22 INFO - Running cycle 1/1 for dromaeo_css test... 22:06:22 INFO - TEST-INFO | started process 4014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkuBskp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:34 INFO - PROCESS | 4014 | RSS: Main: 165146624 22:06:34 INFO - PROCESS | 4014 | 22:07:23 INFO - PROCESS | 4014 | 1470632843878 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] 22:09:36 INFO - PROCESS | 4014 | Cycle 1(1): loaded http://localhost:45771/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45771/tests/dromaeo/cssquery-ext.html) 22:09:37 INFO - PROCESS | 4014 | RSS: Main: 167096320 22:09:37 INFO - PROCESS | 4014 | 22:12:39 INFO - PROCESS | 4014 | Cycle 1(1): loaded http://localhost:45771/tests/dromaeo/cssquery-ext.html (next: http://localhost:45771/tests/dromaeo/cssquery-jquery.html) 22:12:40 INFO - PROCESS | 4014 | RSS: Main: 167559168 22:12:40 INFO - PROCESS | 4014 | 22:15:42 INFO - PROCESS | 4014 | Cycle 1(1): loaded http://localhost:45771/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45771/tests/dromaeo/cssquery-mootools.html) 22:15:43 INFO - PROCESS | 4014 | RSS: Main: 170774528 22:15:43 INFO - PROCESS | 4014 | 22:18:45 INFO - PROCESS | 4014 | Cycle 1(1): loaded http://localhost:45771/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45771/tests/dromaeo/cssquery-prototype.html) 22:18:45 INFO - PROCESS | 4014 | RSS: Main: 164827136 22:18:45 INFO - PROCESS | 4014 | 22:21:48 INFO - PROCESS | 4014 | Cycle 1(1): loaded http://localhost:45771/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45771/tests/dromaeo/cssquery-yui.html) 22:21:49 INFO - PROCESS | 4014 | RSS: Main: 166801408 22:21:49 INFO - PROCESS | 4014 | 22:24:52 INFO - PROCESS | 4014 | Cycle 1(1): loaded http://localhost:45771/tests/dromaeo/cssquery-yui.html (next: http://localhost:45771/tests/dromaeo/cssquery-dojo.html) 22:24:52 INFO - PROCESS | 4014 | RSS: Main: 169938944 22:24:52 INFO - PROCESS | 4014 | 22:24:52 INFO - PROCESS | 4014 | __start_tp_report 22:24:52 INFO - PROCESS | 4014 | _x_x_mozilla_page_load 22:24:52 INFO - PROCESS | 4014 | _x_x_mozilla_page_load_details 22:24:52 INFO - PROCESS | 4014 | |i|pagename|runs| 22:24:52 INFO - PROCESS | 4014 | |0;dojo.html;2673.3583939854434;2676.812623116383;2699.85150816705;2706.634604328416;2721.3468767495797;4531.864044078683;4813.350197723302;4843.878903027417;4852.9272060919075;4885.682430642006;4744.881377965553;4771.974025584499;4774.259989701593;4819.228923372252;4868.4888086750825;4379.474463064436;4419.911601767963;4440.904905303495;4535.297028960516;4626.028534007863;4527.63778897689;4584.564466375689;4591;4615.05391394765;4632.72203667781;4284.67864910133;4383.627391671712;4399.362092496602;4460.553944605514;4496.9775151124195;4366.694331396803;4370.715903466296;4374.256376416017;4451.087527056978;4487.640988720895;4366.223216917376;4383.254846676073;4407.07451435199;4425.181341451842;4460.308652158888;4698.224792909165;4732.1482133216;4781.8087276508895;4820.204666230068;4821.204501257288;5162.793488260465;5166.43169251382;5181.663191892515;5183.792648294064;5187.394501899584;5187.325647665779;5214.217867319894;5214.661047031931;5220.034293655686;5257.185136303879;4697.13103075932;4786.521347865255;4822.228443449031;4836.709797412166;4893.21708526634;5329.440408757102;5333.6266461348105;5336.17289320156;5341.7062061586985;5347.331583552056;5111.744412779346;5114.795408183705;5116.002379535955;5136.897262054738;5137.17805151174;4986.301917731521;5123.897522049539;5150.690958542499;5165.819196328186;5238.476152384731;5101.566366858784;5137.640365174402;5139;5147.974260128675;5156.948430515722;5107.055194788976;5112.182050871917;5128.640995130379;5141.665791723526;5178.404483484373;4130.421740956269;4197.664186865043;4273.722208056529;4300.440942677432;4339.500957389941;3757.680597149218;3758.5113935188797;3771.377722675728;3790.469334293201;3816.198598294334;4412.735235885857;4439.933400998988;4462.44219472566;4462.598366147063;4495.505494395614;5033.5469807716745;5133.717645529532;5145.3568303962;5150.072986862326;5265.420803711589;4471.977640111779;4489.7979590918485;4490.259107247333;4500.144972455289;4529.048899731028;4637.118947399983;4649.279361698942;4649.442066951988;4655.9989602235;4699.647526435531;4726.905461890743;4806.2790581413765;4854.708717476963;4857.077155340616;4922.163232250455;5144.434112247724;5162.845114646567;5198.272241886215;5214.608904332266;5222.451642577475;4860.975695121501;4889.828855990023;4892.828750993698;4900.240462728283;4926.088673595253;4977.4524802271;5075.7969681212335;5128.640995130305;5129.435762066244;5188.9740551297;5229.241759944863;5232.241325007776;5235.424103348552;5240.921386179134;5242.266082748342;5049.419316778471;5056.140456122394;5057.570106540985;5058.873528161826;5075.0357432087785;4766.380370551806;4950.950490495049;4955.231939049453;4967.528084831935;5077.619178561548;4877.80488780459;4947.455779864284;4954.727489988085;4959.652824302264;5014.548690617862;5056.898862022813;5080.949190508048;5082.415522214993;5083.466236045162;5104.69371837691;4763.857084287477;4876.634252431011;4883.658143930033;4925.581325587222;4950.1584730596605 22:24:52 INFO - PROCESS | 4014 | |1;ext.html;543.7797691934767;548.3529435266387;551.2502995925543;558.8323502949115;558.9217509548664;35476.11309717259;39432;39556.20887582246;39586.802065989665;39629.801850990705;40560.79719601405;41514.7924260379;41687.58312416875;41767.58232417675;41845.37231941515;7657.502262352957;7798.532088074705;7800.921990780104;7820.882686759704;7834.05991281047;7714.19001004892;7805.219478052206;7836.412269079813;7839.333656639193;7859.253370929752;7823.765287041398;7897.763067107996;7898.170692077335;7914.208579142098;7935.246151615616;7830.765077047669;7861.842763144762;7865.449418540705;7876.842463150762;7886.842263154762;7726.304632583038;7745.148033716287;7787.727429539996;7804.492707973964;7808.102068262109;38171;38660.420093698616;38673.41989870154;38716.22567548662;38732.80633596814;3078.507438809802;3460.8615655373756;3718.0704823794053;3728.6457786510236;3812.1041555234497;29603.259918501994;29739.851300743358;29930;30187.245318866986;30720;3105.922351941197;3131.686831316873;3142.6228852537615;3222.2266656002625;3241.61100667919;256754;256945;258005;258638.4293492115;259473;32066.519002214984;33232.833835830665;54894.72552637211;54911;55339.72330138324;33920;34188.31623367569;34214.48678269828;34235.486467703005;34262.14344641404;12857.614271571681;12988.090833641743;12988.415521301564;12989.545365912149;12997.675058123623;10396.22028347877;10441.686749397379;10509.789804203872;10519.684409467729;10535.84196237057;7796.571188584682;7944.165862584461;7994.5203287802915;7994.64024118916;8027.15714849944;3023;3096.34976654905;3097.4889143291102;3112.7042930921525;3141.0576826951824;839.4040231435627;875.7635438431588;894.9821003580022;903.3721563513295;926.4626516620344;27556.862215688794;28235;28502.144935651962;28778.424431511252;28819.56770648442;940.2759874896292;972.5720682899502;998.1665309466676;1046.4610725476387;1076.6285631457135;14028.579142625533;14653.706925861636;14715.92642036783;14843.92578037103;14849.109053456827;380760;383424;383449;385772;387217;49052.7547362268;49558;50076.49923500791;50086;50246.24630630543;1163.627639155462;1181.6336935550007;1197.1320792425422;1199.7600479904054;1203.3562044306254;26538;27434.45131097407;28006;28674.426511470072;28721;43841.34237986369;44079;44105.77947110244;44193;44314.556854431044;345644;346568;346915;347642;347906;25697.743022569535;25890.87054564715;26086.739132608433;26360.4727905437;26375.4724905497;42821.35767963421;43851.12297754091;44690.55309446864;44835.55164448444;45194.0961180768;36268.45597315989;37119.44320835244;37643;37706.8114659425;38606.4209036859;36696.26607467889;36924;37102.628973709914;37151;37497.81251093727;35075.12312192216;36273.455898161024;37003.44494832526;37547.62452375441;40397.19205615812;31773;34546.82726586351;34598.13504662403;34981.47527787136;35477.29045419025;25411;25602.487950240517;25767.484650306513;25866.35334116662;26036.739632603432 22:24:52 INFO - PROCESS | 4014 | |2;jquery.html;342.50679022208004;359.89922821609946;361.416312655062;364.47515577568316;373.5666626713012;16089.51731448057;16794.83205167948;17365.56586085347;17368.56578585536;17377.13114344281;14773.630659233524;15219.315130819112;15404;15405;15428.15145167018;4402.713823601463;4633.930491042637;4678.415198100238;4760.09558183944;4766.428028636568;3536;4722.362481065046;4744.098621261966;5722.599418040739;5976.432238937316;6036.637801731888;6051.727672254759;6052.3356077078715;6057.212562366908;6058;5985.102234664813;6014;6014.89497643958;6032.306284777241;6043.728032238516;5065.797368105272;5230.032443997835;5281.52466278033;5282.313299271109;5284.313039304904;20280.188792448283;20306.593868122556;21008.159673613038;21043;21140.894295528426;1914.510942539908;1945.5330720626948;1962.8233458988616;1987.4633848860726;2065.710800487933;9226.861597075982;9412;9499.572519236652;9511.90488095124;9555.665551705726;1737.3050779688099;1746.4585978346627;1762.3215062201145;1770.3184274054581;1840.4938641873457;73055.90416143816;73228.63385683038;74018.62990685066;74136.25863741347;75174.62412687902;9165.679201227926;9407.717768466957;9439.952800235955;10027.298089133836;10295.94852025735;13655.180689158682;13673.794893076612;13694.520691775939;13745.725085498234;13747.312634368242;6882.518223724292;7007.579545227302;7065.2228254891925;7254.093238345207;7264.963675181591;6617.900731489031;6708.463322934153;6899.137607799025;6920.653967301615;6949.305069493112;4179.26862799009;4293.381037567082;4300.268954277781;4353.151135528605;4460.888477788081;1625.821159672435;1681.6468541606155;1722.2336060452978;1787.4637608717592;1834.7614810074872;759.9354054905396;840.315143158324;901.7520181949885;907.1925985872579;925.4586067150658;16464.4237451691;16691;16729.91635041817;17070.829291706923;17109.82890171082;810.0239211749828;816.1715858403725;822.7284995951321;836.4730219961507;859.1408591408591;8841.55792210387;9605.711828645151;9621.807563848684;9643.566039528238;9789.46157961319;367464;370172;373453;373519;376801;73627.63186184035;74176;75203.24796751962;76913.23086769061;77926.6103669478;887.5118684723376;900.2662829793697;900.5857305639479;904.5025236120108;909.9226565741986;13427.597172084854;15846.514788526561;16058.43795467153;16066.919665401598;16477.58806029859;37074;37754;38552;39668.801655991534;39888.40167397433;48973.75513122412;50121.24818127658;51458.48541514537;51535.48464515457;51999.2200116991;7628.656710447932;7656.464047516621;7668.501547399401;7742.65158067877;7809.726659566888;10504.264701470824;11960;12406.317652529198;12504.374781260718;12742.10805243624;4958.404991401055;7386.741464048732;10433.9478302608;10451.268411211142;10566.577336906745;10650.147988161083;10681.51933162994;10841.241113122005;10852.837207442053;10934.179936504635;10328;10461.633842815465;10664.520096595517;10806.567737290734;10950.56197752081;7457.440691948234;7650.120236172911;7689.846203076019;7791.259830316111;7913.485623434458;9799.314048016571;10094.24293178;10437.634682786065;10521.526531305957;10642.521086550969 22:24:52 INFO - PROCESS | 4014 | |3;mootools.html;1336.0380526021268;1378.159322813084;1436.985630143699;1678.8824782265247;1684.4609724888032;6428.871422571546;7342.743003994861;7475.401967842573;7882.211778822115;7895;7574.583397913113;7674.539527628346;7692.576908270043;7710.11333696625;7713.190115037911;2113.260358874393;2154.956900861982;2156.3962090614573;2163.9134434622597;2163.9891800541054;2098.821600163988;2116.7459904811444;2169.305822136917;2172.978270217301;2177.4447515883508;2138.0699395762817;2141.132841199309;2141.6680414535695;2161.1247444784885;2170.8588941718817;2071.98964005179;2087.9895600521977;2095.124863247385;2097.475631092227;2102.358780571925;2007.4078146946686;2046.6316063108634;2056.598963202176;2064.1846470644014;2067.989660051705;7799.610019499002;7841.725539606144;7909.525428474252;7932;7957.084935232465;4180.498340199165;4276.893077673052;4281.721688090264;4311.051568654891;4313.439252897103;2624.973750262492;2734.302752798024;2745.862706864669;2769.1692492252246;2830.5754136879427;865.904750477447;881.1805021330224;902.4585248850702;911.9452832829985;915.158054589779;10090.69727908164;10102.39385636864;10132.746681332952;10133.341332813417;10137.391756494633;3879.6702280305926;4008.8997775055273;4173.812178451977;4182.707210495297;4210.242156411875;8716.694915677921;8719.651213951498;8723.302135829119;8727.694530691395;8774.692885748967;4321.070969741458;4334.436523251957;4375.584319489643;4380.255356589324;4391.473023237232;3291.7037466628117;3922.2939870823525;3939.468171796828;3976.065624578222;4038.818253178614;3425.8629654814026;3459;3534.8232588370993;3593.3711600470338;3611.476335931275;1140.1733743036398;1156.259993604094;1168.894799468052;1179.7109708121566;1187.6140254417348;722.8048426924701;830.1781236575747;833.5915401453244;843.5697794124918;844.5650489997656;4991.326170966873;5186.455422180692;5219.399769026534;5262;5280.577553795764;403.12722954802524;408.4261612434534;410.1694069509208;410.9773962432095;411.92173487037365;3532.533998390639;3541.415666415064;3598.8020658864016;3600.981995090008;3643.708503319728;9259.907400926038;9516.476593787269;9543.379680320757;9579;9698.224142068617;9537.523123843781;9543.570539325747;9580.95209523948;9600.087991640783;9632.90367096334;7286.453515986323;7349.77950661481;7358.300961408658;7371.705131794775;7385.261473852679;5141.38303403579;5159.226116082617;5190.766415511235;5221.503957124067;5286.471352864836;8603.913960860562;8813;8853;8909.821803563762;8915.37592368528;8817.559122043744;8865.734027979172;8929.06244844308;9027.593758281024;9074.909250907407;5686.914696279477;6520.9347906520325;6771.3905748482875;6830.282820303995;6855.965720171367;7385.778426647209;7434.888476672746;7451.3293803557945;7455.92544074574;7475.925240747741;6735.090762746966;6739.898901516579;6776.661166941534;6843.076184715;7068.399186069241;6506.219253689587;6646.867062658816;6650.667466626746;6729.865402692017;6762.797116086525;6201.751929922752;6220.844478888064;6284.591501552384;6285.874282514233;6291.811245662638;4126.773027483518;4488.461384633865;4587.564181402761;4587.587117159472;4634.884127896695;4437.511873693956;4497.8200871964755;4544.341070544819;4572;4655.6973796703105 22:24:52 INFO - PROCESS | 4014 | |4;prototype.html;283.1660759064555;285.57306826294695;290.75867030364793;293.67255510106236;295.44603867747975;5118.974405127974;5138.177891537355;5147.5624571911385;5150.896982060356;5157.277981082642;5026.648134630577;5028.723420211887;5037.949620503794;5044.596432285418;5053.140966035774;3703.2038111805955;3769.2649933263024;3855.3445914194513;3903.316919539069;3916.843326266946;3878.3600705883496;3905.453236546886;3908.7850168240734;3912.882613521599;3930.960690393102;3891.241207964448;3897.512810898638;3909;3911.628395302456;3924.136689928211;3802.6007269236884;3881.243157584272;3914.3345631242473;3917.1773927475265;3917.334053210961;3384.272381438003;3384.9492257616157;3389.2543640399317;3402.4896265560114;3413.74396920232;4875.854174269044;4894.975525122351;4895.779689913962;4907.527741677518;4918.286848406997;4392.989612389137;4497.010657655311;4497.460304763449;4507.278835386355;4521.615662668677;5233.502817232356;5243.689077730567;5249.501297376743;5256.500632439912;5260.790018295814;3727.7763334200035;3739.513863197767;3739.719521035933;3759.4172903200047;3763.4193638671823;5352.518273355417;5553.6390134641115;5559.221708960748;5589.469000444951;5592.720363981784;3799.4422286862805;3819.751716138442;3823.7323387362617;3824.521934758155;3832.6742226911024;3868.9613103869165;3876.4494202319297;3882.8835134946;3886.4558961744815;3892.1826416452295;4451.577100175478;4454.844080457168;4455.888602784957;4499.10017996402;4499.6400287976885;5000.674956127913;5265.367316341829;5347.839564813062;5347.876945841417;5364.14173732201;1301.1542497376593;1309.4565755211481;1309.5612969655272;1311.5475161069417;1313.9868601314056;791.9168487308865;817.2113910076804;820.5815034332534;843.7004863273572;847.2882778466118;4411.411891718979;4540.954590454053;4678.228092364721;4701.365315682339;4710.481846996828;5482.643628164156;5488.682716148096;5493.571671365394;5505;5519.862003449865;4650.116477869194;4675.509071547506;4684.367610372556;4691.62467002639;4706.647001474903;2796.8321900686024;2943.67619561848;2944.3228057546885;2962.4223276461316;2966.718161774628;5155.510226528474;5176.094183517869;5198.4007996002;5202.739863006835;5221.373435187726;5365.570754339644;5630.859228519238;5649.378568357477;5693.572982026365;5705.5150312223095;5114.539691427789;5139.486051394831;5145.716985565755;5152.948470515397;5157.174852023658;5467.589930755289;5498.532624726943;5501.972490137524;5509.834704958857;5537.169424586345;5233.241180028798;5375.3280839895015;5386.13821788512;5399.595030372816;5439.864003399788;5110.66780659256;5149.201873709581;5151.330327057459;5169.198774190007;5175.844724658266;3828.626251723949;3863.74885632433;3866.4007078902814;3872.2642697887313;3872.903177420474;5346.572274217975;5447.591430642797;5526;5540.335159780852;5587.497125258747;5242.895142097213;5269.868253293698;5270.156774915995;5300.443453437488;5325.227841962971;5263.605229607718;5272.075692372333;5344.118220493575;5350.411454740053;5365.597580181424;4968.205087186033;5236.272030230091;5246.868828279171;5252.028374750684;5269.341332333458;5111.747621832675;5178.275041494118;5304.602154838325;5361.195820626937;5396.271503347155;5205.349331333583;5211.244369566468;5215.348081489814;5220;5234.450382709761 22:24:52 INFO - PROCESS | 4014 | |5;yui.html;570.6205373426673;574.4054903175214;582.8659408336083;591.6036255708675;608.8782243551291;12421.56524521642;12845.80731289029;13319.134256273335;13382.866171338295;13721.176729396218;14371.496997605085;14389.78415323771;14584.708305833878;14592.4892628758;14623.341949612266;744.3821628048706;771.4908160613996;771.961401929904;774.2180397798209;775.7633921653893;624.7438550194421;750.3247077630122;770.8496843115595;772.5635016215848;775.9650815713278;805.1465446626565;807.2210317044052;809.5021561739546;811.853866304065;812.5815205169342;798.8082860113589;804.0953926832314;805.0420000199744;806.4878801960767;807.7859367267679;583.614814222611;583.7139801497236;585.3853453873459;586.5835256967558;586.9647821130745;13532.458701651922;13598.04813663044;13599.252041137734;13615.931920340434;13643.522476713366;13238.404271807793;13278.673826198696;13439;13515;13577.932110339385;10243.385396876136;10302.639407620773;10315.123214526775;10353;10403;3222.5971753530807;3250.089974807058;3255.918602034968;3281.1140991932284;3289.243474000993;50399.74800126012;52482.73758631221;52606;53755.731221343645;69447;10462.843057354146;10548.683539493828;10609.257351985441;10762.461876906124;10764.569417223223;20296.289629862884;20333.288334908502;20548.58902821935;20623.69064464034;21066.2626808061;6926.61903595297;6955.1653801544135;6966.407855332353;6981.581105133709;7042.436605071684;3641.7997010164167;3674.889753307405;3681.116532032293;3746.3631182699005;3805.6765174960437;2872.1670715492273;2934.0464349086633;2966.718161774628;2966.9109926702235;2967.109867039879;497.14739222234044;501.08551892795066;545.4381986553856;556.6966003528087;574.7327492715824;473.16958737415615;474.2885671492761;474.468595173408;481.51607634327274;485.39083450269686;7677.462577619624;7894.21057894206;8036.598170091589;8174.6730130795295;8570.92863392076;429.20811103513967;442.6901169181521;453.1277291214399;489.4360092140801;545.9563234941195;3752.699784017272;3884.2231553689376;3947.743396679207;3982.48227730399;3989;87393;88900.5554972221;89496;89947.55026224827;91452.54273728588;61354.38645613576;78191.21808781954;80009;83130.58434707788;85118;70175.2982470179;73384.63307683427;74137.62931185418;74243.25756742363;74556.62721686465;8233.259006689426;8447.281981031681;8531.189536993976;8574.22831945128;8857.601407936529;37774.811125944194;38101.237975240896;38154.61845381511;43480.34779478374;44946.77526612346;52247.21629175489;57711.422885770604;59207;59304.70347648234;59893.40106598878;10078.596856125967;10427.635032773816;10575.576976920836;10874.782504350027;10952.616658416917;12139.453724582592;12192.817107743214;12703.856687692198;12722.109452338247;13297.734045319234;11743.588974385855;11926.926576608146;12286.877131228573;12636.684082897633;12644.873551264369;12030.699232519257;12337.629871103882;12458.31479268649;12503.124781265587;12567.748645026866;11602.361870096887;11664.416779160838;11812;11832.526698931946;11955.402229888297;9945.900540994497;9959.651412200537;10219.846702299323;10326.277160598685;11070.944645276722;9985.251106166921;10472.424016679155;10501.107405870587;10763.51564179598;10841.07850832688 22:24:52 INFO - PROCESS | 4014 | __end_tp_report 22:24:52 INFO - PROCESS | 4014 | __start_cc_report 22:24:52 INFO - PROCESS | 4014 | _x_x_mozilla_cycle_collect,389 22:24:52 INFO - PROCESS | 4014 | __end_cc_report 22:24:52 INFO - PROCESS | 4014 | __startTimestamp1470633892329__endTimestamp 22:24:52 INFO - PROCESS | 4014 | 22:24:52 INFO - PROCESS | 4014 | ------- Summary: start ------- 22:24:52 INFO - PROCESS | 4014 | Number of tests: 6 22:24:52 INFO - PROCESS | 4014 | 22:24:52 INFO - PROCESS | 4014 | [#0] dojo.html Cycles:165 Average:4768.41 Median:4883.66 stddev:508.41 (10.4%) stddev-sans-first:482.67 22:24:52 INFO - PROCESS | 4014 | Values: 2673.4 2676.8 2699.9 2706.6 2721.3 4531.9 4813.4 4843.9 4852.9 4885.7 4744.9 4772.0 4774.3 4819.2 4868.5 4379.5 4419.9 4440.9 4535.3 4626.0 4527.6 4584.6 4591.0 4615.1 4632.7 4284.7 4383.6 4399.4 4460.6 4497.0 4366.7 4370.7 4374.3 4451.1 4487.6 4366.2 4383.3 4407.1 4425.2 4460.3 4698.2 4732.1 4781.8 4820.2 4821.2 5162.8 5166.4 5181.7 5183.8 5187.4 5187.3 5214.2 5214.7 5220.0 5257.2 4697.1 4786.5 4822.2 4836.7 4893.2 5329.4 5333.6 5336.2 5341.7 5347.3 5111.7 5114.8 5116.0 5136.9 5137.2 4986.3 5123.9 5150.7 5165.8 5238.5 5101.6 5137.6 5139.0 5148.0 5156.9 5107.1 5112.2 5128.6 5141.7 5178.4 4130.4 4197.7 4273.7 4300.4 4339.5 3757.7 3758.5 3771.4 3790.5 3816.2 4412.7 4439.9 4462.4 4462.6 4495.5 5033.5 5133.7 5145.4 5150.1 5265.4 4472.0 4489.8 4490.3 4500.1 4529.0 4637.1 4649.3 4649.4 4656.0 4699.6 4726.9 4806.3 4854.7 4857.1 4922.2 5144.4 5162.8 5198.3 5214.6 5222.5 4861.0 4889.8 4892.8 4900.2 4926.1 4977.5 5075.8 5128.6 5129.4 5189.0 5229.2 5232.2 5235.4 5240.9 5242.3 5049.4 5056.1 5057.6 5058.9 5075.0 4766.4 4951.0 4955.2 4967.5 5077.6 4877.8 4947.5 4954.7 4959.7 5014.5 5056.9 5080.9 5082.4 5083.5 5104.7 4763.9 4876.6 4883.7 4925.6 4950.2 22:24:52 INFO - PROCESS | 4014 | 22:24:52 INFO - PROCESS | 4014 | [#1] ext.html Cycles:180 Average:47473.67 Median:20434.54 stddev:88108.07 (431.2%) stddev-sans-first:88284.77 22:24:52 INFO - PROCESS | 4014 | Values: 543.8 548.4 551.3 558.8 558.9 35476.1 39432.0 39556.2 39586.8 39629.8 40560.8 41514.8 41687.6 41767.6 41845.4 7657.5 7798.5 7800.9 7820.9 7834.1 7714.2 7805.2 7836.4 7839.3 7859.3 7823.8 7897.8 7898.2 7914.2 7935.2 7830.8 7861.8 7865.4 7876.8 7886.8 7726.3 7745.1 7787.7 7804.5 7808.1 38171.0 38660.4 38673.4 38716.2 38732.8 3078.5 3460.9 3718.1 3728.6 3812.1 29603.3 29739.9 29930.0 30187.2 30720.0 3105.9 3131.7 3142.6 3222.2 3241.6 256754.0 256945.0 258005.0 258638.4 259473.0 32066.5 33232.8 54894.7 54911.0 55339.7 33920.0 34188.3 34214.5 34235.5 34262.1 12857.6 12988.1 12988.4 12989.5 12997.7 10396.2 10441.7 10509.8 10519.7 10535.8 7796.6 7944.2 7994.5 7994.6 8027.2 3023.0 3096.3 3097.5 3112.7 3141.1 839.4 875.8 895.0 903.4 926.5 27556.9 28235.0 28502.1 28778.4 28819.6 940.3 972.6 998.2 1046.5 1076.6 14028.6 14653.7 14715.9 14843.9 14849.1 380760.0 383424.0 383449.0 385772.0 387217.0 49052.8 49558.0 50076.5 50086.0 50246.2 1163.6 1181.6 1197.1 1199.8 1203.4 26538.0 27434.5 28006.0 28674.4 28721.0 43841.3 44079.0 44105.8 44193.0 44314.6 345644.0 346568.0 346915.0 347642.0 347906.0 25697.7 25890.9 26086.7 26360.5 26375.5 42821.4 43851.1 44690.6 44835.6 45194.1 36268.5 37119.4 37643.0 37706.8 38606.4 36696.3 36924.0 37102.6 37151.0 37497.8 35075.1 36273.5 37003.4 37547.6 40397.2 31773.0 34546.8 34598.1 34981.5 35477.3 25411.0 25602.5 25767.5 25866.4 26036.7 22:24:52 INFO - PROCESS | 4014 | 22:24:52 INFO - PROCESS | 4014 | [#2] jquery.html Cycles:180 Average:23898.62 Median:4547.41 stddev:61678.51 (1356.3%) stddev-sans-first:61826.17 22:24:52 INFO - PROCESS | 4014 | Values: 342.5 359.9 361.4 364.5 373.6 16089.5 16794.8 17365.6 17368.6 17377.1 14773.6 15219.3 15404.0 15405.0 15428.2 4402.7 4633.9 4678.4 4760.1 4766.4 3536.0 4722.4 4744.1 5722.6 5976.4 6036.6 6051.7 6052.3 6057.2 6058.0 5985.1 6014.0 6014.9 6032.3 6043.7 5065.8 5230.0 5281.5 5282.3 5284.3 20280.2 20306.6 21008.2 21043.0 21140.9 1914.5 1945.5 1962.8 1987.5 2065.7 9226.9 9412.0 9499.6 9511.9 9555.7 1737.3 1746.5 1762.3 1770.3 1840.5 73055.9 73228.6 74018.6 74136.3 75174.6 9165.7 9407.7 9440.0 10027.3 10295.9 13655.2 13673.8 13694.5 13745.7 13747.3 6882.5 7007.6 7065.2 7254.1 7265.0 6617.9 6708.5 6899.1 6920.7 6949.3 4179.3 4293.4 4300.3 4353.2 4460.9 1625.8 1681.6 1722.2 1787.5 1834.8 759.9 840.3 901.8 907.2 925.5 16464.4 16691.0 16729.9 17070.8 17109.8 810.0 816.2 822.7 836.5 859.1 8841.6 9605.7 9621.8 9643.6 9789.5 367464.0 370172.0 373453.0 373519.0 376801.0 73627.6 74176.0 75203.2 76913.2 77926.6 887.5 900.3 900.6 904.5 909.9 13427.6 15846.5 16058.4 16066.9 16477.6 37074.0 37754.0 38552.0 39668.8 39888.4 48973.8 50121.2 51458.5 51535.5 51999.2 7628.7 7656.5 7668.5 7742.7 7809.7 10504.3 11960.0 12406.3 12504.4 12742.1 4958.4 7386.7 10433.9 10451.3 10566.6 10650.1 10681.5 10841.2 10852.8 10934.2 10328.0 10461.6 10664.5 10806.6 10950.6 7457.4 7650.1 7689.8 7791.3 7913.5 9799.3 10094.2 10437.6 10521.5 10642.5 22:24:52 INFO - PROCESS | 4014 | 22:24:52 INFO - PROCESS | 4014 | [#3] mootools.html Cycles:180 Average:5026.36 Median:5066.35 stddev:2856.19 (56.4%) stddev-sans-first:2850.74 22:24:52 INFO - PROCESS | 4014 | Values: 1336.0 1378.2 1437.0 1678.9 1684.5 6428.9 7342.7 7475.4 7882.2 7895.0 7574.6 7674.5 7692.6 7710.1 7713.2 2113.3 2155.0 2156.4 2163.9 2164.0 2098.8 2116.7 2169.3 2173.0 2177.4 2138.1 2141.1 2141.7 2161.1 2170.9 2072.0 2088.0 2095.1 2097.5 2102.4 2007.4 2046.6 2056.6 2064.2 2068.0 7799.6 7841.7 7909.5 7932.0 7957.1 4180.5 4276.9 4281.7 4311.1 4313.4 2625.0 2734.3 2745.9 2769.2 2830.6 865.9 881.2 902.5 911.9 915.2 10090.7 10102.4 10132.7 10133.3 10137.4 3879.7 4008.9 4173.8 4182.7 4210.2 8716.7 8719.7 8723.3 8727.7 8774.7 4321.1 4334.4 4375.6 4380.3 4391.5 3291.7 3922.3 3939.5 3976.1 4038.8 3425.9 3459.0 3534.8 3593.4 3611.5 1140.2 1156.3 1168.9 1179.7 1187.6 722.8 830.2 833.6 843.6 844.6 4991.3 5186.5 5219.4 5262.0 5280.6 403.1 408.4 410.2 411.0 411.9 3532.5 3541.4 3598.8 3601.0 3643.7 9259.9 9516.5 9543.4 9579.0 9698.2 9537.5 9543.6 9581.0 9600.1 9632.9 7286.5 7349.8 7358.3 7371.7 7385.3 5141.4 5159.2 5190.8 5221.5 5286.5 8603.9 8813.0 8853.0 8909.8 8915.4 8817.6 8865.7 8929.1 9027.6 9074.9 5686.9 6520.9 6771.4 6830.3 6856.0 7385.8 7434.9 7451.3 7455.9 7475.9 6735.1 6739.9 6776.7 6843.1 7068.4 6506.2 6646.9 6650.7 6729.9 6762.8 6201.8 6220.8 6284.6 6285.9 6291.8 4126.8 4488.5 4587.6 4587.6 4634.9 4437.5 4497.8 4544.3 4572.0 4655.7 22:24:52 INFO - PROCESS | 4014 | 22:24:52 INFO - PROCESS | 4014 | [#4] prototype.html Cycles:180 Average:4393.92 Median:5048.87 stddev:1299.46 (25.7%) stddev-sans-first:1265.95 22:24:52 INFO - PROCESS | 4014 | Values: 283.2 285.6 290.8 293.7 295.4 5119.0 5138.2 5147.6 5150.9 5157.3 5026.6 5028.7 5037.9 5044.6 5053.1 3703.2 3769.3 3855.3 3903.3 3916.8 3878.4 3905.5 3908.8 3912.9 3931.0 3891.2 3897.5 3909.0 3911.6 3924.1 3802.6 3881.2 3914.3 3917.2 3917.3 3384.3 3384.9 3389.3 3402.5 3413.7 4875.9 4895.0 4895.8 4907.5 4918.3 4393.0 4497.0 4497.5 4507.3 4521.6 5233.5 5243.7 5249.5 5256.5 5260.8 3727.8 3739.5 3739.7 3759.4 3763.4 5352.5 5553.6 5559.2 5589.5 5592.7 3799.4 3819.8 3823.7 3824.5 3832.7 3869.0 3876.4 3882.9 3886.5 3892.2 4451.6 4454.8 4455.9 4499.1 4499.6 5000.7 5265.4 5347.8 5347.9 5364.1 1301.2 1309.5 1309.6 1311.5 1314.0 791.9 817.2 820.6 843.7 847.3 4411.4 4541.0 4678.2 4701.4 4710.5 5482.6 5488.7 5493.6 5505.0 5519.9 4650.1 4675.5 4684.4 4691.6 4706.6 2796.8 2943.7 2944.3 2962.4 2966.7 5155.5 5176.1 5198.4 5202.7 5221.4 5365.6 5630.9 5649.4 5693.6 5705.5 5114.5 5139.5 5145.7 5152.9 5157.2 5467.6 5498.5 5502.0 5509.8 5537.2 5233.2 5375.3 5386.1 5399.6 5439.9 5110.7 5149.2 5151.3 5169.2 5175.8 3828.6 3863.7 3866.4 3872.3 3872.9 5346.6 5447.6 5526.0 5540.3 5587.5 5242.9 5269.9 5270.2 5300.4 5325.2 5263.6 5272.1 5344.1 5350.4 5365.6 4968.2 5236.3 5246.9 5252.0 5269.3 5111.7 5178.3 5304.6 5361.2 5396.3 5205.3 5211.2 5215.3 5220.0 5234.5 22:24:52 INFO - PROCESS | 4014 | 22:24:52 INFO - PROCESS | 4014 | [#5] yui.html Cycles:180 Average:17054.68 Median:21954.78 stddev:23452.44 (106.8%) stddev-sans-first:23485.57 22:24:52 INFO - PROCESS | 4014 | Values: 570.6 574.4 582.9 591.6 608.9 12421.6 12845.8 13319.1 13382.9 13721.2 14371.5 14389.8 14584.7 14592.5 14623.3 744.4 771.5 772.0 774.2 775.8 624.7 750.3 770.8 772.6 776.0 805.1 807.2 809.5 811.9 812.6 798.8 804.1 805.0 806.5 807.8 583.6 583.7 585.4 586.6 587.0 13532.5 13598.0 13599.3 13615.9 13643.5 13238.4 13278.7 13439.0 13515.0 13577.9 10243.4 10302.6 10315.1 10353.0 10403.0 3222.6 3250.1 3255.9 3281.1 3289.2 50399.7 52482.7 52606.0 53755.7 69447.0 10462.8 10548.7 10609.3 10762.5 10764.6 20296.3 20333.3 20548.6 20623.7 21066.3 6926.6 6955.2 6966.4 6981.6 7042.4 3641.8 3674.9 3681.1 3746.4 3805.7 2872.2 2934.0 2966.7 2966.9 2967.1 497.1 501.1 545.4 556.7 574.7 473.2 474.3 474.5 481.5 485.4 7677.5 7894.2 8036.6 8174.7 8570.9 429.2 442.7 453.1 489.4 546.0 3752.7 3884.2 3947.7 3982.5 3989.0 87393.0 88900.6 89496.0 89947.6 91452.5 61354.4 78191.2 80009.0 83130.6 85118.0 70175.3 73384.6 74137.6 74243.3 74556.6 8233.3 8447.3 8531.2 8574.2 8857.6 37774.8 38101.2 38154.6 43480.3 44946.8 52247.2 57711.4 59207.0 59304.7 59893.4 10078.6 10427.6 10575.6 10874.8 10952.6 12139.5 12192.8 12703.9 12722.1 13297.7 11743.6 11926.9 12286.9 12636.7 12644.9 12030.7 12337.6 12458.3 12503.1 12567.7 11602.4 11664.4 11812.0 11832.5 11955.4 9945.9 9959.7 10219.8 10326.3 11070.9 9985.3 10472.4 10501.1 10763.5 10841.1 22:24:52 INFO - PROCESS | 4014 | -------- Summary: end -------- 22:24:52 INFO - PROCESS | 4014 | 22:24:53 INFO - TEST-INFO | 4014: exit 0 22:24:53 INFO - TEST-OK | dromaeo_css | took 1117883ms 22:24:53 INFO - TEST-START | kraken 22:24:53 INFO - operating with platform_type : linux_ 22:24:53 INFO - Initialising browser for kraken test... 22:24:53 INFO - TEST-INFO | started process 4259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqUShOi/profile http://localhost:45771/getInfo.html) 22:24:58 INFO - PROCESS | 4259 | __metrics Screen width/height:1600/1200 22:24:58 INFO - PROCESS | 4259 | colorDepth:24 22:24:58 INFO - PROCESS | 4259 | Browser inner width/height: 1024/697 22:24:58 INFO - PROCESS | 4259 | __metrics 22:24:59 ERROR - PROCESS | 4259 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:25:00 INFO - TEST-INFO | 4259: exit 0 22:25:00 INFO - Browser initialized. 22:25:00 INFO - Running cycle 1/1 for kraken test... 22:25:00 INFO - TEST-INFO | started process 4380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqUShOi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:12 INFO - PROCESS | 4380 | RSS: Main: 164712448 22:25:12 INFO - PROCESS | 4380 | 22:25:14 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45771/tests/kraken/driver.html?testName=audio-beat-detection) 22:25:15 INFO - PROCESS | 4380 | RSS: Main: 169517056 22:25:15 INFO - PROCESS | 4380 | 22:25:18 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45771/tests/kraken/driver.html?testName=audio-dft) 22:25:19 INFO - PROCESS | 4380 | RSS: Main: 168824832 22:25:19 INFO - PROCESS | 4380 | 22:25:22 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45771/tests/kraken/driver.html?testName=audio-fft) 22:25:22 INFO - PROCESS | 4380 | RSS: Main: 165425152 22:25:22 INFO - PROCESS | 4380 | 22:25:24 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45771/tests/kraken/driver.html?testName=audio-oscillator) 22:25:25 INFO - PROCESS | 4380 | RSS: Main: 165629952 22:25:25 INFO - PROCESS | 4380 | 22:25:27 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45771/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:25:28 INFO - PROCESS | 4380 | RSS: Main: 166125568 22:25:28 INFO - PROCESS | 4380 | 22:25:31 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45771/tests/kraken/driver.html?testName=imaging-darkroom) 22:25:32 INFO - PROCESS | 4380 | RSS: Main: 166518784 22:25:32 INFO - PROCESS | 4380 | 22:25:35 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45771/tests/kraken/driver.html?testName=imaging-desaturate) 22:25:36 INFO - PROCESS | 4380 | RSS: Main: 163454976 22:25:36 INFO - PROCESS | 4380 | 22:25:39 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45771/tests/kraken/driver.html?testName=json-parse-financial) 22:25:40 INFO - PROCESS | 4380 | RSS: Main: 165416960 22:25:40 INFO - PROCESS | 4380 | 22:25:41 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45771/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:25:42 INFO - PROCESS | 4380 | RSS: Main: 165748736 22:25:42 INFO - PROCESS | 4380 | 22:25:44 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45771/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:25:45 INFO - PROCESS | 4380 | RSS: Main: 165687296 22:25:45 INFO - PROCESS | 4380 | 22:25:47 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45771/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:25:48 INFO - PROCESS | 4380 | RSS: Main: 166207488 22:25:48 INFO - PROCESS | 4380 | 22:25:50 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:25:51 INFO - PROCESS | 4380 | RSS: Main: 166436864 22:25:51 INFO - PROCESS | 4380 | 22:25:54 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:25:55 INFO - PROCESS | 4380 | RSS: Main: 166510592 22:25:55 INFO - PROCESS | 4380 | 22:25:56 INFO - PROCESS | 4380 | Cycle 1(1): loaded http://localhost:45771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45771/tests/kraken/driver.html?testName=ai-astar) 22:25:57 INFO - PROCESS | 4380 | RSS: Main: 167448576 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | __start_tp_report 22:25:57 INFO - PROCESS | 4380 | _x_x_mozilla_page_load 22:25:57 INFO - PROCESS | 4380 | _x_x_mozilla_page_load_details 22:25:57 INFO - PROCESS | 4380 | |i|pagename|runs| 22:25:57 INFO - PROCESS | 4380 | |0;ai-astar;106;117;110;116;115;115;119;114;116;114 22:25:57 INFO - PROCESS | 4380 | |1;audio-beat-detection;162;124;164;184;125;155;148;125;198;126 22:25:57 INFO - PROCESS | 4380 | |2;audio-dft;163;164;169;168;163;165;163;164;164;163 22:25:57 INFO - PROCESS | 4380 | |3;audio-fft;77;76;77;169;77;77;76;79;160;76 22:25:57 INFO - PROCESS | 4380 | |4;audio-oscillator;87;86;145;87;85;86;134;86;86;149 22:25:57 INFO - PROCESS | 4380 | |5;imaging-gaussian-blur;118;118;117;118;118;117;118;121;119;118 22:25:57 INFO - PROCESS | 4380 | |6;imaging-darkroom;149;149;148;148;148;148;148;148;151;148 22:25:57 INFO - PROCESS | 4380 | |7;imaging-desaturate;96;96;96;95;96;96;96;97;96;95 22:25:57 INFO - PROCESS | 4380 | |8;json-parse-financial;64;66;66;64;67;64;65;66;65;67 22:25:57 INFO - PROCESS | 4380 | |9;json-stringify-tinderbox;65;66;67;66;66;72;65;66;65;66 22:25:57 INFO - PROCESS | 4380 | |10;stanford-crypto-aes;88;80;85;95;87;81;81;79;85;82 22:25:57 INFO - PROCESS | 4380 | |11;stanford-crypto-ccm;133;136;137;132;152;140;142;136;147;135 22:25:57 INFO - PROCESS | 4380 | |12;stanford-crypto-pbkdf2;166;166;173;169;169;168;170;170;168;174 22:25:57 INFO - PROCESS | 4380 | |13;stanford-crypto-sha256-iterative;68;70;71;69;70;68;69;73;69;71 22:25:57 INFO - PROCESS | 4380 | __end_tp_report 22:25:57 INFO - PROCESS | 4380 | __start_cc_report 22:25:57 INFO - PROCESS | 4380 | _x_x_mozilla_cycle_collect,980 22:25:57 INFO - PROCESS | 4380 | __end_cc_report 22:25:57 INFO - PROCESS | 4380 | __startTimestamp1470633957121__endTimestamp 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | ------- Summary: start ------- 22:25:57 INFO - PROCESS | 4380 | Number of tests: 14 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.50 stddev:3.71 (3.2%) stddev-sans-first:2.47 22:25:57 INFO - PROCESS | 4380 | Values: 106.0 117.0 110.0 116.0 115.0 115.0 119.0 114.0 116.0 114.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:158.50 stddev:26.50 (16.7%) stddev-sans-first:27.81 22:25:57 INFO - PROCESS | 4380 | Values: 162.0 124.0 164.0 184.0 125.0 155.0 148.0 125.0 198.0 126.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.17 (1.3%) stddev-sans-first:2.22 22:25:57 INFO - PROCESS | 4380 | Values: 163.0 164.0 169.0 168.0 163.0 165.0 163.0 164.0 164.0 163.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#3] audio-fft Cycles:10 Average:94.40 Median:77.00 stddev:37.02 (48.1%) stddev-sans-first:38.72 22:25:57 INFO - PROCESS | 4380 | Values: 77.0 76.0 77.0 169.0 77.0 77.0 76.0 79.0 160.0 76.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:86.00 stddev:27.55 (32.0%) stddev-sans-first:28.60 22:25:57 INFO - PROCESS | 4380 | Values: 87.0 86.0 145.0 87.0 85.0 86.0 134.0 86.0 86.0 149.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 22:25:57 INFO - PROCESS | 4380 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 118.0 121.0 119.0 118.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 22:25:57 INFO - PROCESS | 4380 | Values: 149.0 149.0 148.0 148.0 148.0 148.0 148.0 148.0 151.0 148.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:25:57 INFO - PROCESS | 4380 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 97.0 96.0 95.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:66.00 stddev:1.17 (1.8%) stddev-sans-first:1.13 22:25:57 INFO - PROCESS | 4380 | Values: 64.0 66.0 66.0 64.0 67.0 64.0 65.0 66.0 65.0 67.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:2.07 (3.1%) stddev-sans-first:2.13 22:25:57 INFO - PROCESS | 4380 | Values: 65.0 66.0 67.0 66.0 66.0 72.0 65.0 66.0 65.0 66.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:4.83 (5.7%) stddev-sans-first:4.94 22:25:57 INFO - PROCESS | 4380 | Values: 88.0 80.0 85.0 95.0 87.0 81.0 81.0 79.0 85.0 82.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:138.50 stddev:6.38 (4.6%) stddev-sans-first:6.38 22:25:57 INFO - PROCESS | 4380 | Values: 133.0 136.0 137.0 132.0 152.0 140.0 142.0 136.0 147.0 135.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.50 stddev:2.63 (1.5%) stddev-sans-first:2.50 22:25:57 INFO - PROCESS | 4380 | Values: 166.0 166.0 173.0 169.0 169.0 168.0 170.0 170.0 168.0 174.0 22:25:57 INFO - PROCESS | 4380 | 22:25:57 INFO - PROCESS | 4380 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.55 (2.2%) stddev-sans-first:1.50 22:25:57 INFO - PROCESS | 4380 | Values: 68.0 70.0 71.0 69.0 70.0 68.0 69.0 73.0 69.0 71.0 22:25:57 INFO - PROCESS | 4380 | -------- Summary: end -------- 22:25:57 INFO - PROCESS | 4380 | 22:25:58 INFO - TEST-INFO | 4380: exit 0 22:25:58 INFO - TEST-OK | kraken | took 65037ms 22:25:58 INFO - SUITE-END | took 1182s 22:25:58 INFO - Completed test suite (00:19:42) 22:25:58 INFO - javascript benchmark 22:25:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6344.560992445356, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.3583939854434, 2676.812623116383, 2699.85150816705, 2706.634604328416, 2721.3468767495797, 4531.864044078683, 4813.350197723302, 4843.878903027417, 4852.9272060919075, 4885.682430642006, 4744.881377965553, 4771.974025584499, 4774.259989701593, 4819.228923372252, 4868.4888086750825, 4379.474463064436, 4419.911601767963, 4440.904905303495, 4535.297028960516, 4626.028534007863, 4527.63778897689, 4584.564466375689, 4591.0, 4615.05391394765, 4632.72203667781, 4284.67864910133, 4383.627391671712, 4399.362092496602, 4460.553944605514, 4496.9775151124195, 4366.694331396803, 4370.715903466296, 4374.256376416017, 4451.087527056978, 4487.640988720895, 4366.223216917376, 4383.254846676073, 4407.07451435199, 4425.181341451842, 4460.308652158888, 4698.224792909165, 4732.1482133216, 4781.8087276508895, 4820.204666230068, 4821.204501257288, 5162.793488260465, 5166.43169251382, 5181.663191892515, 5183.792648294064, 5187.394501899584, 5187.325647665779, 5214.217867319894, 5214.661047031931, 5220.034293655686, 5257.185136303879, 4697.13103075932, 4786.521347865255, 4822.228443449031, 4836.709797412166, 4893.21708526634, 5329.440408757102, 5333.6266461348105, 5336.17289320156, 5341.7062061586985, 5347.331583552056, 5111.744412779346, 5114.795408183705, 5116.002379535955, 5136.897262054738, 5137.17805151174, 4986.301917731521, 5123.897522049539, 5150.690958542499, 5165.819196328186, 5238.476152384731, 5101.566366858784, 5137.640365174402, 5139.0, 5147.974260128675, 5156.948430515722, 5107.055194788976, 5112.182050871917, 5128.640995130379, 5141.665791723526, 5178.404483484373, 4130.421740956269, 4197.664186865043, 4273.722208056529, 4300.440942677432, 4339.500957389941, 3757.680597149218, 3758.5113935188797, 3771.377722675728, 3790.469334293201, 3816.198598294334, 4412.735235885857, 4439.933400998988, 4462.44219472566, 4462.598366147063, 4495.505494395614, 5033.5469807716745, 5133.717645529532, 5145.3568303962, 5150.072986862326, 5265.420803711589, 4471.977640111779, 4489.7979590918485, 4490.259107247333, 4500.144972455289, 4529.048899731028, 4637.118947399983, 4649.279361698942, 4649.442066951988, 4655.9989602235, 4699.647526435531, 4726.905461890743, 4806.2790581413765, 4854.708717476963, 4857.077155340616, 4922.163232250455, 5144.434112247724, 5162.845114646567, 5198.272241886215, 5214.608904332266, 5222.451642577475, 4860.975695121501, 4889.828855990023, 4892.828750993698, 4900.240462728283, 4926.088673595253, 4977.4524802271, 5075.7969681212335, 5128.640995130305, 5129.435762066244, 5188.9740551297, 5229.241759944863, 5232.241325007776, 5235.424103348552, 5240.921386179134, 5242.266082748342, 5049.419316778471, 5056.140456122394, 5057.570106540985, 5058.873528161826, 5075.0357432087785, 4766.380370551806, 4950.950490495049, 4955.231939049453, 4967.528084831935, 5077.619178561548, 4877.80488780459, 4947.455779864284, 4954.727489988085, 4959.652824302264, 5014.548690617862, 5056.898862022813, 5080.949190508048, 5082.415522214993, 5083.466236045162, 5104.69371837691, 4763.857084287477, 4876.634252431011, 4883.658143930033, 4925.581325587222, 4950.1584730596605], "value": 4735.6137373951, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.7797691934767, 548.3529435266387, 551.2502995925543, 558.8323502949115, 558.9217509548664, 35476.11309717259, 39432.0, 39556.20887582246, 39586.802065989665, 39629.801850990705, 40560.79719601405, 41514.7924260379, 41687.58312416875, 41767.58232417675, 41845.37231941515, 7657.502262352957, 7798.532088074705, 7800.921990780104, 7820.882686759704, 7834.05991281047, 7714.19001004892, 7805.219478052206, 7836.412269079813, 7839.333656639193, 7859.253370929752, 7823.765287041398, 7897.763067107996, 7898.170692077335, 7914.208579142098, 7935.246151615616, 7830.765077047669, 7861.842763144762, 7865.449418540705, 7876.842463150762, 7886.842263154762, 7726.304632583038, 7745.148033716287, 7787.727429539996, 7804.492707973964, 7808.102068262109, 38171.0, 38660.420093698616, 38673.41989870154, 38716.22567548662, 38732.80633596814, 3078.507438809802, 3460.8615655373756, 3718.0704823794053, 3728.6457786510236, 3812.1041555234497, 29603.259918501994, 29739.851300743358, 29930.0, 30187.245318866986, 30720.0, 3105.922351941197, 3131.686831316873, 3142.6228852537615, 3222.2266656002625, 3241.61100667919, 256754.0, 256945.0, 258005.0, 258638.4293492115, 259473.0, 32066.519002214984, 33232.833835830665, 54894.72552637211, 54911.0, 55339.72330138324, 33920.0, 34188.31623367569, 34214.48678269828, 34235.486467703005, 34262.14344641404, 12857.614271571681, 12988.090833641743, 12988.415521301564, 12989.545365912149, 12997.675058123623, 10396.22028347877, 10441.686749397379, 10509.789804203872, 10519.684409467729, 10535.84196237057, 7796.571188584682, 7944.165862584461, 7994.5203287802915, 7994.64024118916, 8027.15714849944, 3023.0, 3096.34976654905, 3097.4889143291102, 3112.7042930921525, 3141.0576826951824, 839.4040231435627, 875.7635438431588, 894.9821003580022, 903.3721563513295, 926.4626516620344, 27556.862215688794, 28235.0, 28502.144935651962, 28778.424431511252, 28819.56770648442, 940.2759874896292, 972.5720682899502, 998.1665309466676, 1046.4610725476387, 1076.6285631457135, 14028.579142625533, 14653.706925861636, 14715.92642036783, 14843.92578037103, 14849.109053456827, 380760.0, 383424.0, 383449.0, 385772.0, 387217.0, 49052.7547362268, 49558.0, 50076.49923500791, 50086.0, 50246.24630630543, 1163.627639155462, 1181.6336935550007, 1197.1320792425422, 1199.7600479904054, 1203.3562044306254, 26538.0, 27434.45131097407, 28006.0, 28674.426511470072, 28721.0, 43841.34237986369, 44079.0, 44105.77947110244, 44193.0, 44314.556854431044, 345644.0, 346568.0, 346915.0, 347642.0, 347906.0, 25697.743022569535, 25890.87054564715, 26086.739132608433, 26360.4727905437, 26375.4724905497, 42821.35767963421, 43851.12297754091, 44690.55309446864, 44835.55164448444, 45194.0961180768, 36268.45597315989, 37119.44320835244, 37643.0, 37706.8114659425, 38606.4209036859, 36696.26607467889, 36924.0, 37102.628973709914, 37151.0, 37497.81251093727, 35075.12312192216, 36273.455898161024, 37003.44494832526, 37547.62452375441, 40397.19205615812, 31773.0, 34546.82726586351, 34598.13504662403, 34981.47527787136, 35477.29045419025, 25411.0, 25602.487950240517, 25767.484650306513, 25866.35334116662, 26036.739632603432], "value": 16622.556997256128, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.50679022208004, 359.89922821609946, 361.416312655062, 364.47515577568316, 373.5666626713012, 16089.51731448057, 16794.83205167948, 17365.56586085347, 17368.56578585536, 17377.13114344281, 14773.630659233524, 15219.315130819112, 15404.0, 15405.0, 15428.15145167018, 4402.713823601463, 4633.930491042637, 4678.415198100238, 4760.09558183944, 4766.428028636568, 3536.0, 4722.362481065046, 4744.098621261966, 5722.599418040739, 5976.432238937316, 6036.637801731888, 6051.727672254759, 6052.3356077078715, 6057.212562366908, 6058.0, 5985.102234664813, 6014.0, 6014.89497643958, 6032.306284777241, 6043.728032238516, 5065.797368105272, 5230.032443997835, 5281.52466278033, 5282.313299271109, 5284.313039304904, 20280.188792448283, 20306.593868122556, 21008.159673613038, 21043.0, 21140.894295528426, 1914.510942539908, 1945.5330720626948, 1962.8233458988616, 1987.4633848860726, 2065.710800487933, 9226.861597075982, 9412.0, 9499.572519236652, 9511.90488095124, 9555.665551705726, 1737.3050779688099, 1746.4585978346627, 1762.3215062201145, 1770.3184274054581, 1840.4938641873457, 73055.90416143816, 73228.63385683038, 74018.62990685066, 74136.25863741347, 75174.62412687902, 9165.679201227926, 9407.717768466957, 9439.952800235955, 10027.298089133836, 10295.94852025735, 13655.180689158682, 13673.794893076612, 13694.520691775939, 13745.725085498234, 13747.312634368242, 6882.518223724292, 7007.579545227302, 7065.2228254891925, 7254.093238345207, 7264.963675181591, 6617.900731489031, 6708.463322934153, 6899.137607799025, 6920.653967301615, 6949.305069493112, 4179.26862799009, 4293.381037567082, 4300.268954277781, 4353.151135528605, 4460.888477788081, 1625.821159672435, 1681.6468541606155, 1722.2336060452978, 1787.4637608717592, 1834.7614810074872, 759.9354054905396, 840.315143158324, 901.7520181949885, 907.1925985872579, 925.4586067150658, 16464.4237451691, 16691.0, 16729.91635041817, 17070.829291706923, 17109.82890171082, 810.0239211749828, 816.1715858403725, 822.7284995951321, 836.4730219961507, 859.1408591408591, 8841.55792210387, 9605.711828645151, 9621.807563848684, 9643.566039528238, 9789.46157961319, 367464.0, 370172.0, 373453.0, 373519.0, 376801.0, 73627.63186184035, 74176.0, 75203.24796751962, 76913.23086769061, 77926.6103669478, 887.5118684723376, 900.2662829793697, 900.5857305639479, 904.5025236120108, 909.9226565741986, 13427.597172084854, 15846.514788526561, 16058.43795467153, 16066.919665401598, 16477.58806029859, 37074.0, 37754.0, 38552.0, 39668.801655991534, 39888.40167397433, 48973.75513122412, 50121.24818127658, 51458.48541514537, 51535.48464515457, 51999.2200116991, 7628.656710447932, 7656.464047516621, 7668.501547399401, 7742.65158067877, 7809.726659566888, 10504.264701470824, 11960.0, 12406.317652529198, 12504.374781260718, 12742.10805243624, 4958.404991401055, 7386.741464048732, 10433.9478302608, 10451.268411211142, 10566.577336906745, 10650.147988161083, 10681.51933162994, 10841.241113122005, 10852.837207442053, 10934.179936504635, 10328.0, 10461.633842815465, 10664.520096595517, 10806.567737290734, 10950.56197752081, 7457.440691948234, 7650.120236172911, 7689.846203076019, 7791.259830316111, 7913.485623434458, 9799.314048016571, 10094.24293178, 10437.634682786065, 10521.526531305957, 10642.521086550969], "value": 8157.43406010391, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.0380526021268, 1378.159322813084, 1436.985630143699, 1678.8824782265247, 1684.4609724888032, 6428.871422571546, 7342.743003994861, 7475.401967842573, 7882.211778822115, 7895.0, 7574.583397913113, 7674.539527628346, 7692.576908270043, 7710.11333696625, 7713.190115037911, 2113.260358874393, 2154.956900861982, 2156.3962090614573, 2163.9134434622597, 2163.9891800541054, 2098.821600163988, 2116.7459904811444, 2169.305822136917, 2172.978270217301, 2177.4447515883508, 2138.0699395762817, 2141.132841199309, 2141.6680414535695, 2161.1247444784885, 2170.8588941718817, 2071.98964005179, 2087.9895600521977, 2095.124863247385, 2097.475631092227, 2102.358780571925, 2007.4078146946686, 2046.6316063108634, 2056.598963202176, 2064.1846470644014, 2067.989660051705, 7799.610019499002, 7841.725539606144, 7909.525428474252, 7932.0, 7957.084935232465, 4180.498340199165, 4276.893077673052, 4281.721688090264, 4311.051568654891, 4313.439252897103, 2624.973750262492, 2734.302752798024, 2745.862706864669, 2769.1692492252246, 2830.5754136879427, 865.904750477447, 881.1805021330224, 902.4585248850702, 911.9452832829985, 915.158054589779, 10090.69727908164, 10102.39385636864, 10132.746681332952, 10133.341332813417, 10137.391756494633, 3879.6702280305926, 4008.8997775055273, 4173.812178451977, 4182.707210495297, 4210.242156411875, 8716.694915677921, 8719.651213951498, 8723.302135829119, 8727.694530691395, 8774.692885748967, 4321.070969741458, 4334.436523251957, 4375.584319489643, 4380.255356589324, 4391.473023237232, 3291.7037466628117, 3922.2939870823525, 3939.468171796828, 3976.065624578222, 4038.818253178614, 3425.8629654814026, 3459.0, 3534.8232588370993, 3593.3711600470338, 3611.476335931275, 1140.1733743036398, 1156.259993604094, 1168.894799468052, 1179.7109708121566, 1187.6140254417348, 722.8048426924701, 830.1781236575747, 833.5915401453244, 843.5697794124918, 844.5650489997656, 4991.326170966873, 5186.455422180692, 5219.399769026534, 5262.0, 5280.577553795764, 403.12722954802524, 408.4261612434534, 410.1694069509208, 410.9773962432095, 411.92173487037365, 3532.533998390639, 3541.415666415064, 3598.8020658864016, 3600.981995090008, 3643.708503319728, 9259.907400926038, 9516.476593787269, 9543.379680320757, 9579.0, 9698.224142068617, 9537.523123843781, 9543.570539325747, 9580.95209523948, 9600.087991640783, 9632.90367096334, 7286.453515986323, 7349.77950661481, 7358.300961408658, 7371.705131794775, 7385.261473852679, 5141.38303403579, 5159.226116082617, 5190.766415511235, 5221.503957124067, 5286.471352864836, 8603.913960860562, 8813.0, 8853.0, 8909.821803563762, 8915.37592368528, 8817.559122043744, 8865.734027979172, 8929.06244844308, 9027.593758281024, 9074.909250907407, 5686.914696279477, 6520.9347906520325, 6771.3905748482875, 6830.282820303995, 6855.965720171367, 7385.778426647209, 7434.888476672746, 7451.3293803557945, 7455.92544074574, 7475.925240747741, 6735.090762746966, 6739.898901516579, 6776.661166941534, 6843.076184715, 7068.399186069241, 6506.219253689587, 6646.867062658816, 6650.667466626746, 6729.865402692017, 6762.797116086525, 6201.751929922752, 6220.844478888064, 6284.591501552384, 6285.874282514233, 6291.811245662638, 4126.773027483518, 4488.461384633865, 4587.564181402761, 4587.587117159472, 4634.884127896695, 4437.511873693956, 4497.8200871964755, 4544.341070544819, 4572.0, 4655.6973796703105], "value": 3969.9241470539373, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.1660759064555, 285.57306826294695, 290.75867030364793, 293.67255510106236, 295.44603867747975, 5118.974405127974, 5138.177891537355, 5147.5624571911385, 5150.896982060356, 5157.277981082642, 5026.648134630577, 5028.723420211887, 5037.949620503794, 5044.596432285418, 5053.140966035774, 3703.2038111805955, 3769.2649933263024, 3855.3445914194513, 3903.316919539069, 3916.843326266946, 3878.3600705883496, 3905.453236546886, 3908.7850168240734, 3912.882613521599, 3930.960690393102, 3891.241207964448, 3897.512810898638, 3909.0, 3911.628395302456, 3924.136689928211, 3802.6007269236884, 3881.243157584272, 3914.3345631242473, 3917.1773927475265, 3917.334053210961, 3384.272381438003, 3384.9492257616157, 3389.2543640399317, 3402.4896265560114, 3413.74396920232, 4875.854174269044, 4894.975525122351, 4895.779689913962, 4907.527741677518, 4918.286848406997, 4392.989612389137, 4497.010657655311, 4497.460304763449, 4507.278835386355, 4521.615662668677, 5233.502817232356, 5243.689077730567, 5249.501297376743, 5256.500632439912, 5260.790018295814, 3727.7763334200035, 3739.513863197767, 3739.719521035933, 3759.4172903200047, 3763.4193638671823, 5352.518273355417, 5553.6390134641115, 5559.221708960748, 5589.469000444951, 5592.720363981784, 3799.4422286862805, 3819.751716138442, 3823.7323387362617, 3824.521934758155, 3832.6742226911024, 3868.9613103869165, 3876.4494202319297, 3882.8835134946, 3886.4558961744815, 3892.1826416452295, 4451.577100175478, 4454.844080457168, 4455.888602784957, 4499.10017996402, 4499.6400287976885, 5000.674956127913, 5265.367316341829, 5347.839564813062, 5347.876945841417, 5364.14173732201, 1301.1542497376593, 1309.4565755211481, 1309.5612969655272, 1311.5475161069417, 1313.9868601314056, 791.9168487308865, 817.2113910076804, 820.5815034332534, 843.7004863273572, 847.2882778466118, 4411.411891718979, 4540.954590454053, 4678.228092364721, 4701.365315682339, 4710.481846996828, 5482.643628164156, 5488.682716148096, 5493.571671365394, 5505.0, 5519.862003449865, 4650.116477869194, 4675.509071547506, 4684.367610372556, 4691.62467002639, 4706.647001474903, 2796.8321900686024, 2943.67619561848, 2944.3228057546885, 2962.4223276461316, 2966.718161774628, 5155.510226528474, 5176.094183517869, 5198.4007996002, 5202.739863006835, 5221.373435187726, 5365.570754339644, 5630.859228519238, 5649.378568357477, 5693.572982026365, 5705.5150312223095, 5114.539691427789, 5139.486051394831, 5145.716985565755, 5152.948470515397, 5157.174852023658, 5467.589930755289, 5498.532624726943, 5501.972490137524, 5509.834704958857, 5537.169424586345, 5233.241180028798, 5375.3280839895015, 5386.13821788512, 5399.595030372816, 5439.864003399788, 5110.66780659256, 5149.201873709581, 5151.330327057459, 5169.198774190007, 5175.844724658266, 3828.626251723949, 3863.74885632433, 3866.4007078902814, 3872.2642697887313, 3872.903177420474, 5346.572274217975, 5447.591430642797, 5526.0, 5540.335159780852, 5587.497125258747, 5242.895142097213, 5269.868253293698, 5270.156774915995, 5300.443453437488, 5325.227841962971, 5263.605229607718, 5272.075692372333, 5344.118220493575, 5350.411454740053, 5365.597580181424, 4968.205087186033, 5236.272030230091, 5246.868828279171, 5252.028374750684, 5269.341332333458, 5111.747621832675, 5178.275041494118, 5304.602154838325, 5361.195820626937, 5396.271503347155, 5205.349331333583, 5211.244369566468, 5215.348081489814, 5220.0, 5234.450382709761], "value": 3967.1588074692154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6205373426673, 574.4054903175214, 582.8659408336083, 591.6036255708675, 608.8782243551291, 12421.56524521642, 12845.80731289029, 13319.134256273335, 13382.866171338295, 13721.176729396218, 14371.496997605085, 14389.78415323771, 14584.708305833878, 14592.4892628758, 14623.341949612266, 744.3821628048706, 771.4908160613996, 771.961401929904, 774.2180397798209, 775.7633921653893, 624.7438550194421, 750.3247077630122, 770.8496843115595, 772.5635016215848, 775.9650815713278, 805.1465446626565, 807.2210317044052, 809.5021561739546, 811.853866304065, 812.5815205169342, 798.8082860113589, 804.0953926832314, 805.0420000199744, 806.4878801960767, 807.7859367267679, 583.614814222611, 583.7139801497236, 585.3853453873459, 586.5835256967558, 586.9647821130745, 13532.458701651922, 13598.04813663044, 13599.252041137734, 13615.931920340434, 13643.522476713366, 13238.404271807793, 13278.673826198696, 13439.0, 13515.0, 13577.932110339385, 10243.385396876136, 10302.639407620773, 10315.123214526775, 10353.0, 10403.0, 3222.5971753530807, 3250.089974807058, 3255.918602034968, 3281.1140991932284, 3289.243474000993, 50399.74800126012, 52482.73758631221, 52606.0, 53755.731221343645, 69447.0, 10462.843057354146, 10548.683539493828, 10609.257351985441, 10762.461876906124, 10764.569417223223, 20296.289629862884, 20333.288334908502, 20548.58902821935, 20623.69064464034, 21066.2626808061, 6926.61903595297, 6955.1653801544135, 6966.407855332353, 6981.581105133709, 7042.436605071684, 3641.7997010164167, 3674.889753307405, 3681.116532032293, 3746.3631182699005, 3805.6765174960437, 2872.1670715492273, 2934.0464349086633, 2966.718161774628, 2966.9109926702235, 2967.109867039879, 497.14739222234044, 501.08551892795066, 545.4381986553856, 556.6966003528087, 574.7327492715824, 473.16958737415615, 474.2885671492761, 474.468595173408, 481.51607634327274, 485.39083450269686, 7677.462577619624, 7894.21057894206, 8036.598170091589, 8174.6730130795295, 8570.92863392076, 429.20811103513967, 442.6901169181521, 453.1277291214399, 489.4360092140801, 545.9563234941195, 3752.699784017272, 3884.2231553689376, 3947.743396679207, 3982.48227730399, 3989.0, 87393.0, 88900.5554972221, 89496.0, 89947.55026224827, 91452.54273728588, 61354.38645613576, 78191.21808781954, 80009.0, 83130.58434707788, 85118.0, 70175.2982470179, 73384.63307683427, 74137.62931185418, 74243.25756742363, 74556.62721686465, 8233.259006689426, 8447.281981031681, 8531.189536993976, 8574.22831945128, 8857.601407936529, 37774.811125944194, 38101.237975240896, 38154.61845381511, 43480.34779478374, 44946.77526612346, 52247.21629175489, 57711.422885770604, 59207.0, 59304.70347648234, 59893.40106598878, 10078.596856125967, 10427.635032773816, 10575.576976920836, 10874.782504350027, 10952.616658416917, 12139.453724582592, 12192.817107743214, 12703.856687692198, 12722.109452338247, 13297.734045319234, 11743.588974385855, 11926.926576608146, 12286.877131228573, 12636.684082897633, 12644.873551264369, 12030.699232519257, 12337.629871103882, 12458.31479268649, 12503.124781265587, 12567.748645026866, 11602.361870096887, 11664.416779160838, 11812.0, 11832.526698931946, 11955.402229888297, 9945.900540994497, 9959.651412200537, 10219.846702299323, 10326.277160598685, 11070.944645276722, 9985.251106166921, 10472.424016679155, 10501.107405870587, 10763.51564179598, 10841.07850832688], "value": 6448.718594939196, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 110.0, 116.0, 115.0, 115.0, 119.0, 114.0, 116.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 124.0, 164.0, 184.0, 125.0, 155.0, 148.0, 125.0, 198.0, 126.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 169.0, 168.0, 163.0, 165.0, 163.0, 164.0, 164.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 169.0, 77.0, 77.0, 76.0, 79.0, 160.0, 76.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 145.0, 87.0, 85.0, 86.0, 134.0, 86.0, 86.0, 149.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 121.0, 119.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 151.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 64.0, 67.0, 64.0, 65.0, 66.0, 65.0, 67.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 66.0, 72.0, 65.0, 66.0, 65.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 80.0, 85.0, 95.0, 87.0, 81.0, 81.0, 79.0, 85.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 136.0, 137.0, 132.0, 152.0, 140.0, 142.0, 136.0, 147.0, 135.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 173.0, 169.0, 169.0, 168.0, 170.0, 170.0, 168.0, 174.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 71.0, 69.0, 70.0, 68.0, 69.0, 73.0, 69.0, 71.0], "value": 69.8, "unit": "score"}]}]} 22:25:58 INFO - Return code: 0 22:25:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:25:58 ERROR - # TBPL SUCCESS # 22:25:58 INFO - Running post-action listener: _resource_record_post_action 22:25:58 INFO - [mozharness: 2016-08-08 05:25:58.406784Z] Finished run-tests step (success) 22:25:58 INFO - Running post-run listener: _resource_record_post_run 22:25:58 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 546181120; Read time: 896; Write time: 1138908 22:25:58 INFO - TinderboxPrint: CPU usage
13.4% 22:25:58 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 896 22:25:58 INFO - TinderboxPrint: I/O write bytes / time
546,181,120 / 1,138,908 22:25:58 INFO - TinderboxPrint: CPU idle
8,292.3 (86.6%) 22:25:58 INFO - TinderboxPrint: CPU user
1,219.4 (12.7%) 22:25:58 INFO - TinderboxPrint: Swap in / out
0 / 0 22:25:58 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 4096; Write bytes: 248963072; Read time: 412; Write time: 685048 22:25:58 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297218048; Read time: 484; Write time: 453860 22:25:59 INFO - Running post-run listener: _upload_blobber_files 22:25:59 INFO - Blob upload gear active. 22:25:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:25:59 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 22:25:59 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'] 22:25:59 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 22:25:59 INFO - (blobuploader) - INFO - Open directory for files ... 22:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:03 INFO - (blobuploader) - INFO - Done attempting. 22:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:03 INFO - (blobuploader) - INFO - Done attempting. 22:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:26:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:04 INFO - (blobuploader) - INFO - Done attempting. 22:26:04 INFO - (blobuploader) - INFO - Iteration through files over. 22:26:04 INFO - Return code: 0 22:26:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:26:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:26:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e6770fd7ea5af7dedca6ab3ed05f1bb5d9d10849dd097551554669dd61111c09fdeb0bf13f2fbb800269f51e442f1cc47abc850f067677ad56c19488929fff84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dabbe490388d407a1857fdf68c6089f3b708dc60c18051c9b827da156b83691601a5dc78bbf78229c973a9a29a64dc7df813f4e06352a9893538787f1aadbd14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9bc1d7f1d9179801fe338664f0a71fe2607d62422bf19ce4fd607c7dffc1e8e1612a94c9fd899fbfcb2feb8d43ec0d8c9d32bf570765d380a5a0907472c4a2f0"} 22:26:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:26:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:26:04 INFO - Contents: 22:26:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e6770fd7ea5af7dedca6ab3ed05f1bb5d9d10849dd097551554669dd61111c09fdeb0bf13f2fbb800269f51e442f1cc47abc850f067677ad56c19488929fff84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dabbe490388d407a1857fdf68c6089f3b708dc60c18051c9b827da156b83691601a5dc78bbf78229c973a9a29a64dc7df813f4e06352a9893538787f1aadbd14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9bc1d7f1d9179801fe338664f0a71fe2607d62422bf19ce4fd607c7dffc1e8e1612a94c9fd899fbfcb2feb8d43ec0d8c9d32bf570765d380a5a0907472c4a2f0"} 22:26:04 INFO - Running post-run listener: copy_logs_to_upload_dir 22:26:04 INFO - Copying logs to upload dir... 22:26:04 INFO - mkdir: /builds/slave/test/build/upload/logs 22:26:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.138883 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-07 22:26:03.627809) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 22:26:03.631579) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1470631035.477024-729702597 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/e6770fd7ea5af7dedca6ab3ed05f1bb5d9d10849dd097551554669dd61111c09fdeb0bf13f2fbb800269f51e442f1cc47abc850f067677ad56c19488929fff84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dabbe490388d407a1857fdf68c6089f3b708dc60c18051c9b827da156b83691601a5dc78bbf78229c973a9a29a64dc7df813f4e06352a9893538787f1aadbd14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9bc1d7f1d9179801fe338664f0a71fe2607d62422bf19ce4fd607c7dffc1e8e1612a94c9fd899fbfcb2feb8d43ec0d8c9d32bf570765d380a5a0907472c4a2f0"} build_url:https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011113 build_url: 'https://queue.taskcluster.net/v1/task/AWWFB6H-Sf6AQ1xidjVnIg/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/e6770fd7ea5af7dedca6ab3ed05f1bb5d9d10849dd097551554669dd61111c09fdeb0bf13f2fbb800269f51e442f1cc47abc850f067677ad56c19488929fff84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dabbe490388d407a1857fdf68c6089f3b708dc60c18051c9b827da156b83691601a5dc78bbf78229c973a9a29a64dc7df813f4e06352a9893538787f1aadbd14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9bc1d7f1d9179801fe338664f0a71fe2607d62422bf19ce4fd607c7dffc1e8e1612a94c9fd899fbfcb2feb8d43ec0d8c9d32bf570765d380a5a0907472c4a2f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 22:26:03.666964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:26:03.669991) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1470631035.477024-729702597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:26:03.755010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 22:26:03.755428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 22:26:03.756887) ========= ========= Total master_lag: 0.20 =========