builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1470801899.25 results: success (0) buildid: 20160809183001 builduid: 7829f6a628ea491eb4d3e10f7f40e457 revision: 15d404ae1609b59cc09436df4f3a1ed46a57346d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 21:04:59.251820) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 21:04:59.252370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 21:04:59.252699) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 21:04:59.330254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:04:59.330565) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 21:05:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-08-09 21:05:00 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116378 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:04:59.461915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:04:59.462260) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020780 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:04:59.515667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:04:59.516488) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 15d404ae1609b59cc09436df4f3a1ed46a57346d --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 15d404ae1609b59cc09436df4f3a1ed46a57346d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 21:05:00,279 truncating revision to first 12 chars 2016-08-09 21:05:00,279 Setting DEBUG logging. 2016-08-09 21:05:00,279 attempt 1/10 2016-08-09 21:05:00,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/15d404ae1609?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 21:05:00,693 unpacking tar archive at: autoland-15d404ae1609/testing/mozharness/ program finished with exit code 0 elapsedTime=0.755869 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:05:00.290512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 21:05:00.290882) ========= script_repo_revision: 15d404ae1609b59cc09436df4f3a1ed46a57346d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 21:05:00.291398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 21:05:00.291740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 21:05:00.301188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-09 21:05:00.301549) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:05:01 INFO - MultiFileLogger online at 20160809 21:05:01 in /builds/slave/test 21:05:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:05:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:05:01 INFO - {'append_to_log': False, 21:05:01 INFO - 'base_work_dir': '/builds/slave/test', 21:05:01 INFO - 'blob_upload_branch': 'Autoland', 21:05:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:05:01 INFO - 'branch': 'Autoland', 21:05:01 INFO - 'buildbot_json_path': 'buildprops.json', 21:05:01 INFO - 'config_files': ('talos/linux_config.py',), 21:05:01 INFO - 'default_actions': ('clobber', 21:05:01 INFO - 'read-buildbot-config', 21:05:01 INFO - 'download-and-extract', 21:05:01 INFO - 'populate-webroot', 21:05:01 INFO - 'create-virtualenv', 21:05:01 INFO - 'install', 21:05:01 INFO - 'run-tests'), 21:05:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:05:01 INFO - 'download_minidump_stackwalk': True, 21:05:01 INFO - 'download_symbols': 'ondemand', 21:05:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:05:01 INFO - 'tooltool.py': '/tools/tooltool.py', 21:05:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:05:01 INFO - '/tools/misc-python/virtualenv.py')}, 21:05:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:05:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:05:01 INFO - 'installer_path': 'installer.exe', 21:05:01 INFO - 'log_level': 'info', 21:05:01 INFO - 'log_name': 'talos', 21:05:01 INFO - 'log_to_console': True, 21:05:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:05:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:05:01 INFO - 'opt_config_files': (), 21:05:01 INFO - 'pip_index': False, 21:05:01 INFO - 'sps_profile': False, 21:05:01 INFO - 'sps_profile_interval': 0, 21:05:01 INFO - 'suite': 'dromaeojs-e10s', 21:05:01 INFO - 'system_bits': '32', 21:05:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:05:01 INFO - 'title': 'talos-linux64-ix-050', 21:05:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:05:01 INFO - 'use_talos_json': True, 21:05:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:05:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:05:01 INFO - 'work_dir': 'build'} 21:05:01 INFO - [mozharness: 2016-08-10 04:05:01.150548Z] Running clobber step. 21:05:01 INFO - Running pre-action listener: _resource_record_pre_action 21:05:01 INFO - Running main action method: clobber 21:05:01 INFO - rmtree: /builds/slave/test/build 21:05:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:05:01 INFO - Running post-action listener: _resource_record_post_action 21:05:01 INFO - [mozharness: 2016-08-10 04:05:01.612672Z] Finished clobber step (success) 21:05:01 INFO - [mozharness: 2016-08-10 04:05:01.612774Z] Running read-buildbot-config step. 21:05:01 INFO - Running pre-action listener: _resource_record_pre_action 21:05:01 INFO - Running main action method: read_buildbot_config 21:05:01 INFO - Using buildbot properties: 21:05:01 INFO - { 21:05:01 INFO - "project": "", 21:05:01 INFO - "product": "firefox", 21:05:01 INFO - "script_repo_revision": "production", 21:05:01 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 21:05:01 INFO - "repository": "", 21:05:01 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 21:05:01 INFO - "buildid": "20160809183001", 21:05:01 INFO - "pgo_build": "True", 21:05:01 INFO - "basedir": "/builds/slave/test", 21:05:01 INFO - "buildnumber": 115, 21:05:01 INFO - "slavename": "talos-linux64-ix-050", 21:05:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:05:01 INFO - "platform": "ubuntu64_hw", 21:05:01 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:05:01 INFO - "branch": "autoland", 21:05:01 INFO - "repo_path": "integration/autoland", 21:05:01 INFO - "revision": "15d404ae1609b59cc09436df4f3a1ed46a57346d", 21:05:01 INFO - "stage_platform": "linux64-pgo", 21:05:01 INFO - "builduid": "7829f6a628ea491eb4d3e10f7f40e457", 21:05:01 INFO - "slavebuilddir": "test" 21:05:01 INFO - } 21:05:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 21:05:01 INFO - Running post-action listener: _resource_record_post_action 21:05:01 INFO - [mozharness: 2016-08-10 04:05:01.615241Z] Finished read-buildbot-config step (success) 21:05:01 INFO - [mozharness: 2016-08-10 04:05:01.615330Z] Running download-and-extract step. 21:05:01 INFO - Running pre-action listener: _resource_record_pre_action 21:05:01 INFO - Running main action method: download_and_extract 21:05:01 INFO - mkdir: /builds/slave/test/build/tests 21:05:01 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')]} 21:05:01 INFO - trying https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:05:01 INFO - Downloading https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:05:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:05:02 INFO - Downloaded 1361 bytes. 21:05:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:05:02 INFO - Using the following test package requirements: 21:05:02 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:05:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:05:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:05:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:02 INFO - u'jsshell-linux-x86_64.zip'], 21:05:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:05:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:05:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:05:02 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:05:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:05:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:05:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:02 INFO - trying https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:05:02 INFO - Downloading https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:05:03 INFO - Downloaded 21831190 bytes. 21:05:03 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'] 21:05:03 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 21:05:04 INFO - Return code: 0 21:05:04 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 21:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:04 INFO - trying https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:05:04 INFO - Downloading https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:05:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:05:05 INFO - Downloaded 21831190 bytes. 21:05:05 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'] 21:05:05 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 21:05:06 INFO - Return code: 0 21:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:06 INFO - trying https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:05:06 INFO - Downloading https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:05:08 INFO - Downloaded 14413723 bytes. 21:05:08 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'] 21:05:08 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 21:05:08 INFO - Return code: 0 21:05:08 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')]} 21:05:08 INFO - trying https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:05:08 INFO - Downloading https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:05:11 INFO - Downloaded 59343507 bytes. 21:05:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:05:11 INFO - mkdir: /builds/slave/test/properties 21:05:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:05:11 INFO - Writing to file /builds/slave/test/properties/build_url 21:05:11 INFO - Contents: 21:05:11 INFO - build_url:https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:05:12 INFO - Running post-action listener: _resource_record_post_action 21:05:12 INFO - Running post-action listener: set_extra_try_arguments 21:05:12 INFO - [mozharness: 2016-08-10 04:05:12.128279Z] Finished download-and-extract step (success) 21:05:12 INFO - [mozharness: 2016-08-10 04:05:12.128512Z] Running populate-webroot step. 21:05:12 INFO - Running pre-action listener: _resource_record_pre_action 21:05:12 INFO - Running main action method: populate_webroot 21:05:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:05:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:05:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:05:12 INFO - '--tppagecycles', 21:05:12 INFO - '7'], 21:05:12 INFO - 'tests': ['tsvgm']}}, 21:05:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:05:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:05:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:05:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:05:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:12 INFO - 'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:05:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:05:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:12 INFO - 'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['damp', 'tps']}, 21:05:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:12 INFO - 'tests': ['damp', 'tps']}, 21:05:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['dromaeo_dom']}, 21:05:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:05:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['basic_compositor_video']}, 21:05:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:05:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['a11yr', 21:05:12 INFO - 'ts_paint', 21:05:12 INFO - 'tpaint', 21:05:12 INFO - 'sessionrestore', 21:05:12 INFO - 'sessionrestore_no_auto_restore', 21:05:12 INFO - 'tabpaint']}, 21:05:12 INFO - 'other-e10s': {'tests': ['a11yr', 21:05:12 INFO - 'ts_paint', 21:05:12 INFO - 'tpaint', 21:05:12 INFO - 'sessionrestore', 21:05:12 INFO - 'sessionrestore_no_auto_restore', 21:05:12 INFO - 'tabpaint']}, 21:05:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:05:12 INFO - 'ts_paint', 21:05:12 INFO - 'tpaint', 21:05:12 INFO - 'sessionrestore', 21:05:12 INFO - 'sessionrestore_no_auto_restore', 21:05:12 INFO - 'tabpaint']}, 21:05:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:05:12 INFO - 'ts_paint', 21:05:12 INFO - 'tpaint', 21:05:12 INFO - 'sessionrestore', 21:05:12 INFO - 'sessionrestore_no_auto_restore', 21:05:12 INFO - 'tabpaint']}, 21:05:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['a11yr', 21:05:12 INFO - 'ts_paint', 21:05:12 INFO - 'tpaint', 21:05:12 INFO - 'sessionrestore', 21:05:12 INFO - 'sessionrestore_no_auto_restore', 21:05:12 INFO - 'tabpaint']}, 21:05:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['a11yr', 21:05:12 INFO - 'ts_paint', 21:05:12 INFO - 'tpaint', 21:05:12 INFO - 'sessionrestore', 21:05:12 INFO - 'sessionrestore_no_auto_restore', 21:05:12 INFO - 'tabpaint']}, 21:05:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['tsvgx', 21:05:12 INFO - 'tsvgr_opacity', 21:05:12 INFO - 'tart', 21:05:12 INFO - 'tscrollx', 21:05:12 INFO - 'cart']}, 21:05:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:05:12 INFO - 'tsvgr_opacity', 21:05:12 INFO - 'tart', 21:05:12 INFO - 'tscrollx', 21:05:12 INFO - 'cart']}, 21:05:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:12 INFO - 'talos_options': ['--disable-e10s'], 21:05:12 INFO - 'tests': ['tp5o']}, 21:05:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:12 INFO - 'tests': ['tp5o']}, 21:05:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:12 INFO - 'talos_options': ['--disable-e10s', 21:05:12 INFO - '--xperf_path', 21:05:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:05:12 INFO - 'tests': ['tp5n']}, 21:05:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:12 INFO - 'talos_options': ['--xperf_path', 21:05:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:05:12 INFO - 'tests': ['tp5n']}}, 21:05:12 INFO - 'talos.zip': {'path': '', 21:05:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:05:12 INFO - Running post-action listener: _resource_record_post_action 21:05:12 INFO - [mozharness: 2016-08-10 04:05:12.149744Z] Finished populate-webroot step (success) 21:05:12 INFO - [mozharness: 2016-08-10 04:05:12.149834Z] Running create-virtualenv step. 21:05:12 INFO - Running pre-action listener: _resource_record_pre_action 21:05:12 INFO - Running main action method: create_virtualenv 21:05:12 INFO - Creating virtualenv /builds/slave/test/build/venv 21:05:12 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 21:05:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:05:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:05:12 INFO - Using real prefix '/usr' 21:05:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:05:12 INFO - Installing distribute.............................................................................................................................................................................................done. 21:05:14 INFO - Installing pip.................done. 21:05:14 INFO - Return code: 0 21:05:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:05:14 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')]} 21:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:14 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')]} 21:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:14 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 0x1420030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', '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 21:05:14 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 21:05:14 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 21:05:14 INFO - Using env: {'DISPLAY': ':0', 21:05:14 INFO - 'HOME': '/home/cltbld', 21:05:14 INFO - 'LANG': 'en_US.UTF-8', 21:05:14 INFO - 'LANGUAGE': 'en_US:en', 21:05:14 INFO - 'LOGNAME': 'cltbld', 21:05:14 INFO - 'MAIL': '/var/mail/cltbld', 21:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:14 INFO - 'MOZ_NO_REMOTE': '1', 21:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:14 INFO - 'NO_EM_RESTART': '1', 21:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:14 INFO - 'PWD': '/builds/slave/test', 21:05:14 INFO - 'SHELL': '/bin/bash', 21:05:14 INFO - 'SHLVL': '1', 21:05:14 INFO - 'TERM': 'linux', 21:05:14 INFO - 'TMOUT': '86400', 21:05:14 INFO - 'USER': 'cltbld', 21:05:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:14 INFO - '_': '/tools/buildbot/bin/python'} 21:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:14 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 21:05:14 INFO - Cleaning up... 21:05:14 INFO - Return code: 0 21:05:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:05:14 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')]} 21:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:14 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')]} 21:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:14 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 0x1420030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', '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 21:05:14 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 21:05:14 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 21:05:14 INFO - Using env: {'DISPLAY': ':0', 21:05:14 INFO - 'HOME': '/home/cltbld', 21:05:14 INFO - 'LANG': 'en_US.UTF-8', 21:05:14 INFO - 'LANGUAGE': 'en_US:en', 21:05:14 INFO - 'LOGNAME': 'cltbld', 21:05:14 INFO - 'MAIL': '/var/mail/cltbld', 21:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:14 INFO - 'MOZ_NO_REMOTE': '1', 21:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:14 INFO - 'NO_EM_RESTART': '1', 21:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:14 INFO - 'PWD': '/builds/slave/test', 21:05:14 INFO - 'SHELL': '/bin/bash', 21:05:14 INFO - 'SHLVL': '1', 21:05:14 INFO - 'TERM': 'linux', 21:05:14 INFO - 'TMOUT': '86400', 21:05:14 INFO - 'USER': 'cltbld', 21:05:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:14 INFO - '_': '/tools/buildbot/bin/python'} 21:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:15 INFO - Downloading/unpacking psutil>=3.1.1 21:05:15 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 21:05:15 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 21:05:15 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 21:05:15 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 21:05:15 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 21:05:15 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 21:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:05:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:05:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:05:17 INFO - Installing collected packages: psutil 21:05:17 INFO - Running setup.py install for psutil 21:05:17 INFO - building 'psutil._psutil_linux' extension 21:05:17 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 21:05:17 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 21:05:17 INFO - building 'psutil._psutil_posix' extension 21:05:17 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 21:05:17 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 21:05:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:05:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:05:17 INFO - Successfully installed psutil 21:05:17 INFO - Cleaning up... 21:05:17 INFO - Return code: 0 21:05:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:17 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 0x1420030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', '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 21:05:17 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 21:05:17 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 21:05:17 INFO - Using env: {'DISPLAY': ':0', 21:05:17 INFO - 'HOME': '/home/cltbld', 21:05:17 INFO - 'LANG': 'en_US.UTF-8', 21:05:17 INFO - 'LANGUAGE': 'en_US:en', 21:05:17 INFO - 'LOGNAME': 'cltbld', 21:05:17 INFO - 'MAIL': '/var/mail/cltbld', 21:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:17 INFO - 'MOZ_NO_REMOTE': '1', 21:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:17 INFO - 'NO_EM_RESTART': '1', 21:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:17 INFO - 'PWD': '/builds/slave/test', 21:05:17 INFO - 'SHELL': '/bin/bash', 21:05:17 INFO - 'SHLVL': '1', 21:05:17 INFO - 'TERM': 'linux', 21:05:17 INFO - 'TMOUT': '86400', 21:05:17 INFO - 'USER': 'cltbld', 21:05:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:17 INFO - '_': '/tools/buildbot/bin/python'} 21:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:05:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:05:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:05:19 INFO - Installing collected packages: mozsystemmonitor 21:05:19 INFO - Running setup.py install for mozsystemmonitor 21:05:19 INFO - Successfully installed mozsystemmonitor 21:05:19 INFO - Cleaning up... 21:05:20 INFO - Return code: 0 21:05:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1420030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', '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 21:05:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:05:20 INFO - Using env: {'DISPLAY': ':0', 21:05:20 INFO - 'HOME': '/home/cltbld', 21:05:20 INFO - 'LANG': 'en_US.UTF-8', 21:05:20 INFO - 'LANGUAGE': 'en_US:en', 21:05:20 INFO - 'LOGNAME': 'cltbld', 21:05:20 INFO - 'MAIL': '/var/mail/cltbld', 21:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:20 INFO - 'MOZ_NO_REMOTE': '1', 21:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:20 INFO - 'NO_EM_RESTART': '1', 21:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:20 INFO - 'PWD': '/builds/slave/test', 21:05:20 INFO - 'SHELL': '/bin/bash', 21:05:20 INFO - 'SHLVL': '1', 21:05:20 INFO - 'TERM': 'linux', 21:05:20 INFO - 'TMOUT': '86400', 21:05:20 INFO - 'USER': 'cltbld', 21:05:20 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:20 INFO - '_': '/tools/buildbot/bin/python'} 21:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:20 INFO - Downloading/unpacking jsonschema==2.5.1 21:05:20 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 21:05:20 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 21:05:20 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 21:05:20 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 21:05:20 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 21:05:20 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 21:05:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:05:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:05:22 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 21:05:22 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 21:05:22 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 21:05:22 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 21:05:22 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 21:05:22 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 21:05:22 INFO - Downloading functools32-3.2.3-2.tar.gz 21:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:05:22 INFO - warning: no files found matching '*.txt' 21:05:22 INFO - no previously-included directories found matching 'build' 21:05:22 INFO - no previously-included directories found matching 'dist' 21:05:22 INFO - no previously-included directories found matching '.git*' 21:05:22 INFO - Installing collected packages: jsonschema, functools32 21:05:22 INFO - Running setup.py install for functools32 21:05:22 INFO - warning: no files found matching '*.txt' 21:05:22 INFO - no previously-included directories found matching 'build' 21:05:22 INFO - no previously-included directories found matching 'dist' 21:05:22 INFO - no previously-included directories found matching '.git*' 21:05:22 INFO - Successfully installed jsonschema functools32 21:05:22 INFO - Cleaning up... 21:05:22 INFO - Return code: 0 21:05:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:22 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 0x1420030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', '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 21:05:22 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 21:05:22 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 21:05:22 INFO - Using env: {'DISPLAY': ':0', 21:05:22 INFO - 'HOME': '/home/cltbld', 21:05:22 INFO - 'LANG': 'en_US.UTF-8', 21:05:22 INFO - 'LANGUAGE': 'en_US:en', 21:05:22 INFO - 'LOGNAME': 'cltbld', 21:05:22 INFO - 'MAIL': '/var/mail/cltbld', 21:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:22 INFO - 'MOZ_NO_REMOTE': '1', 21:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:22 INFO - 'NO_EM_RESTART': '1', 21:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:22 INFO - 'PWD': '/builds/slave/test', 21:05:22 INFO - 'SHELL': '/bin/bash', 21:05:22 INFO - 'SHLVL': '1', 21:05:22 INFO - 'TERM': 'linux', 21:05:22 INFO - 'TMOUT': '86400', 21:05:22 INFO - 'USER': 'cltbld', 21:05:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:22 INFO - '_': '/tools/buildbot/bin/python'} 21:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:05:22 INFO - Cleaning up... 21:05:22 INFO - Return code: 0 21:05:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:22 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 0x1420030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', '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 21:05:22 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 21:05:22 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 21:05:22 INFO - Using env: {'DISPLAY': ':0', 21:05:22 INFO - 'HOME': '/home/cltbld', 21:05:22 INFO - 'LANG': 'en_US.UTF-8', 21:05:22 INFO - 'LANGUAGE': 'en_US:en', 21:05:22 INFO - 'LOGNAME': 'cltbld', 21:05:22 INFO - 'MAIL': '/var/mail/cltbld', 21:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:22 INFO - 'MOZ_NO_REMOTE': '1', 21:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:22 INFO - 'NO_EM_RESTART': '1', 21:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:22 INFO - 'PWD': '/builds/slave/test', 21:05:22 INFO - 'SHELL': '/bin/bash', 21:05:22 INFO - 'SHLVL': '1', 21:05:22 INFO - 'TERM': 'linux', 21:05:22 INFO - 'TMOUT': '86400', 21:05:22 INFO - 'USER': 'cltbld', 21:05:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:22 INFO - '_': '/tools/buildbot/bin/python'} 21:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:23 INFO - Downloading/unpacking blobuploader==1.2.4 21:05:23 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 21:05:23 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 21:05:23 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 21:05:23 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 21:05:23 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 21:05:23 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 21:05:24 INFO - Downloading blobuploader-1.2.4.tar.gz 21:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:05:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:05:25 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 21:05:25 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 21:05:25 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 21:05:25 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 21:05:25 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 21:05:25 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 21:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:05:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:05:25 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 21:05:25 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 21:05:25 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 21:05:25 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 21:05:25 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 21:05:25 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 21:05:25 INFO - Downloading docopt-0.6.1.tar.gz 21:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:05:25 INFO - Installing collected packages: blobuploader, requests, docopt 21:05:25 INFO - Running setup.py install for blobuploader 21:05:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:05:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:05:25 INFO - Running setup.py install for requests 21:05:26 INFO - Running setup.py install for docopt 21:05:26 INFO - Successfully installed blobuploader requests docopt 21:05:26 INFO - Cleaning up... 21:05:26 INFO - Return code: 0 21:05:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:05:26 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')]} 21:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:26 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')]} 21:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:26 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 0x1420030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', '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 21:05:26 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 21:05:26 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 21:05:26 INFO - Using env: {'DISPLAY': ':0', 21:05:26 INFO - 'HOME': '/home/cltbld', 21:05:26 INFO - 'LANG': 'en_US.UTF-8', 21:05:26 INFO - 'LANGUAGE': 'en_US:en', 21:05:26 INFO - 'LOGNAME': 'cltbld', 21:05:26 INFO - 'MAIL': '/var/mail/cltbld', 21:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:26 INFO - 'MOZ_NO_REMOTE': '1', 21:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:26 INFO - 'NO_EM_RESTART': '1', 21:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:26 INFO - 'PWD': '/builds/slave/test', 21:05:26 INFO - 'SHELL': '/bin/bash', 21:05:26 INFO - 'SHLVL': '1', 21:05:26 INFO - 'TERM': 'linux', 21:05:26 INFO - 'TMOUT': '86400', 21:05:26 INFO - 'USER': 'cltbld', 21:05:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:26 INFO - '_': '/tools/buildbot/bin/python'} 21:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:05:26 INFO - Running setup.py (path:/tmp/pip-xHvzj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:05:26 INFO - Running setup.py (path:/tmp/pip-i1mcf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:05:26 INFO - Running setup.py (path:/tmp/pip-wnnPZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:05:26 INFO - Running setup.py (path:/tmp/pip-I3yn1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:05:26 INFO - Running setup.py (path:/tmp/pip-hITPu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:05:26 INFO - Running setup.py (path:/tmp/pip-BiMoO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:05:26 INFO - Running setup.py (path:/tmp/pip-tCAFxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:05:27 INFO - Running setup.py (path:/tmp/pip-PkvPy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:05:27 INFO - Running setup.py (path:/tmp/pip-NhHp8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:05:27 INFO - Running setup.py (path:/tmp/pip-07cwnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:05:27 INFO - Running setup.py (path:/tmp/pip-HMu4vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:05:27 INFO - Running setup.py (path:/tmp/pip-0Ld7B8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:05:27 INFO - Running setup.py (path:/tmp/pip-DUp6fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:05:27 INFO - Running setup.py (path:/tmp/pip-lTKxXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:05:27 INFO - Running setup.py (path:/tmp/pip-nyYXLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:05:27 INFO - Running setup.py (path:/tmp/pip-wqeo8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:05:27 INFO - Running setup.py (path:/tmp/pip-BE3BIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:05:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:05:27 INFO - Running setup.py install for manifestparser 21:05:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:05:27 INFO - Running setup.py install for mozcrash 21:05:27 INFO - Running setup.py install for mozdebug 21:05:28 INFO - Running setup.py install for mozdevice 21:05:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:05:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:05:28 INFO - Running setup.py install for mozfile 21:05:28 INFO - Running setup.py install for mozhttpd 21:05:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:05:28 INFO - Running setup.py install for mozinfo 21:05:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:05:28 INFO - Running setup.py install for mozInstall 21:05:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:05:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:05:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:05:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:05:28 INFO - Running setup.py install for mozleak 21:05:28 INFO - Running setup.py install for mozlog 21:05:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:05:28 INFO - Running setup.py install for moznetwork 21:05:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:05:28 INFO - Running setup.py install for mozprocess 21:05:28 INFO - Running setup.py install for mozprofile 21:05:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:05:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:05:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:05:29 INFO - Running setup.py install for mozrunner 21:05:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:05:29 INFO - Running setup.py install for mozscreenshot 21:05:29 INFO - Running setup.py install for moztest 21:05:29 INFO - Running setup.py install for mozversion 21:05:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:05:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:05:29 INFO - Cleaning up... 21:05:29 INFO - Return code: 0 21:05:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21: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')]} 21:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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')]} 21:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:29 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 0x1420030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', '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 21:05:29 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 21:05:29 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 21:05:29 INFO - Using env: {'DISPLAY': ':0', 21:05:29 INFO - 'HOME': '/home/cltbld', 21:05:29 INFO - 'LANG': 'en_US.UTF-8', 21:05:29 INFO - 'LANGUAGE': 'en_US:en', 21:05:29 INFO - 'LOGNAME': 'cltbld', 21:05:29 INFO - 'MAIL': '/var/mail/cltbld', 21:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:29 INFO - 'MOZ_NO_REMOTE': '1', 21:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:29 INFO - 'NO_EM_RESTART': '1', 21:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:29 INFO - 'PWD': '/builds/slave/test', 21:05:29 INFO - 'SHELL': '/bin/bash', 21:05:29 INFO - 'SHLVL': '1', 21:05:29 INFO - 'TERM': 'linux', 21:05:29 INFO - 'TMOUT': '86400', 21:05:29 INFO - 'USER': 'cltbld', 21:05:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:29 INFO - '_': '/tools/buildbot/bin/python'} 21:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:05:29 INFO - Running setup.py (path:/tmp/pip-XYtGhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:05:29 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)) 21:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:05:29 INFO - Running setup.py (path:/tmp/pip-b1x_3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:05:29 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)) 21:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:05:29 INFO - Running setup.py (path:/tmp/pip-yp26pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:05:30 INFO - Running setup.py (path:/tmp/pip-pC0vfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:05:30 INFO - Running setup.py (path:/tmp/pip-uP2LNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:05:30 INFO - Running setup.py (path:/tmp/pip-zn9S7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:05:30 INFO - Running setup.py (path:/tmp/pip-WYICui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:05:30 INFO - Running setup.py (path:/tmp/pip-0dRlyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:05:30 INFO - Running setup.py (path:/tmp/pip-OfaKEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:05:30 INFO - Running setup.py (path:/tmp/pip-JMzjxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:05:30 INFO - Running setup.py (path:/tmp/pip-s86Kb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:05:30 INFO - Running setup.py (path:/tmp/pip-0j2j3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:05:30 INFO - Running setup.py (path:/tmp/pip-mkkCR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:05:30 INFO - Running setup.py (path:/tmp/pip-WBCEUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:05:30 INFO - Running setup.py (path:/tmp/pip-b_N03b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:05:30 INFO - Running setup.py (path:/tmp/pip-plzeWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:05:30 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)) 21:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:05:30 INFO - Running setup.py (path:/tmp/pip-hlahBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:05:31 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)) 21:05:31 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)) 21:05:31 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)) 21:05:31 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)) 21:05:31 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)) 21:05:31 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)) 21:05:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:05:31 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 21:05:31 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 21:05:31 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 21:05:31 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 21:05:31 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 21:05:31 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 21:05:32 INFO - Downloading blessings-1.6.tar.gz 21:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:05:32 INFO - Installing collected packages: blessings 21:05:32 INFO - Running setup.py install for blessings 21:05:33 INFO - Successfully installed blessings 21:05:33 INFO - Cleaning up... 21:05:33 INFO - Return code: 0 21:05:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:05:33 INFO - Reading from file tmpfile_stdout 21:05:33 INFO - Current package versions: 21:05:33 INFO - argparse == 1.2.1 21:05:33 INFO - blessings == 1.6 21:05:33 INFO - blobuploader == 1.2.4 21:05:33 INFO - docopt == 0.6.1 21:05:33 INFO - functools32 == 3.2.3-2 21:05:33 INFO - jsonschema == 2.5.1 21:05:33 INFO - manifestparser == 1.1 21:05:33 INFO - mozInstall == 1.12 21:05:33 INFO - mozcrash == 0.17 21:05:33 INFO - mozdebug == 0.1 21:05:33 INFO - mozdevice == 0.48 21:05:33 INFO - mozfile == 1.2 21:05:33 INFO - mozhttpd == 0.7 21:05:33 INFO - mozinfo == 0.9 21:05:33 INFO - mozleak == 0.1 21:05:33 INFO - mozlog == 3.3 21:05:33 INFO - moznetwork == 0.27 21:05:33 INFO - mozprocess == 0.23 21:05:33 INFO - mozprofile == 0.28 21:05:33 INFO - mozrunner == 6.12 21:05:33 INFO - mozscreenshot == 0.1 21:05:33 INFO - mozsystemmonitor == 0.3 21:05:33 INFO - moztest == 0.7 21:05:33 INFO - mozversion == 1.4 21:05:33 INFO - psutil == 3.1.1 21:05:33 INFO - requests == 1.2.3 21:05:33 INFO - wsgiref == 0.1.2 21:05:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21: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')]} 21:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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')]} 21:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:33 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 0x1420030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', '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 21:05:33 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 21:05:33 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 21:05:33 INFO - Using env: {'DISPLAY': ':0', 21:05:33 INFO - 'HOME': '/home/cltbld', 21:05:33 INFO - 'LANG': 'en_US.UTF-8', 21:05:33 INFO - 'LANGUAGE': 'en_US:en', 21:05:33 INFO - 'LOGNAME': 'cltbld', 21:05:33 INFO - 'MAIL': '/var/mail/cltbld', 21:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:33 INFO - 'MOZ_NO_REMOTE': '1', 21:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:33 INFO - 'NO_EM_RESTART': '1', 21:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:33 INFO - 'PWD': '/builds/slave/test', 21:05:33 INFO - 'SHELL': '/bin/bash', 21:05:33 INFO - 'SHLVL': '1', 21:05:33 INFO - 'TERM': 'linux', 21:05:33 INFO - 'TMOUT': '86400', 21:05:33 INFO - 'USER': 'cltbld', 21:05:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:33 INFO - '_': '/tools/buildbot/bin/python'} 21:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:33 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)) 21:05:33 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)) 21:05:33 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)) 21:05:33 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)) 21:05:33 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)) 21:05:33 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)) 21:05:33 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)) 21:05:33 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)) 21:05:33 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)) 21:05:33 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)) 21:05:33 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)) 21:05:33 INFO - Cleaning up... 21:05:33 INFO - Return code: 0 21:05:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21: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')]} 21:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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')]} 21:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:33 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 0x1420030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', '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 21:05:33 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 21:05:33 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 21:05:33 INFO - Using env: {'DISPLAY': ':0', 21:05:33 INFO - 'HOME': '/home/cltbld', 21:05:33 INFO - 'LANG': 'en_US.UTF-8', 21:05:33 INFO - 'LANGUAGE': 'en_US:en', 21:05:33 INFO - 'LOGNAME': 'cltbld', 21:05:33 INFO - 'MAIL': '/var/mail/cltbld', 21:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:33 INFO - 'MOZ_NO_REMOTE': '1', 21:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:33 INFO - 'NO_EM_RESTART': '1', 21:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:33 INFO - 'PWD': '/builds/slave/test', 21:05:33 INFO - 'SHELL': '/bin/bash', 21:05:33 INFO - 'SHLVL': '1', 21:05:33 INFO - 'TERM': 'linux', 21:05:33 INFO - 'TMOUT': '86400', 21:05:33 INFO - 'USER': 'cltbld', 21:05:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:33 INFO - '_': '/tools/buildbot/bin/python'} 21:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:05:33 INFO - Cleaning up... 21:05:33 INFO - Return code: 0 21:05:33 INFO - Running post-action listener: _resource_record_post_action 21:05:33 INFO - Running post-action listener: _start_resource_monitoring 21:05:33 INFO - Starting resource monitoring. 21:05:33 INFO - [mozharness: 2016-08-10 04:05:33.817805Z] Finished create-virtualenv step (success) 21:05:33 INFO - [mozharness: 2016-08-10 04:05:33.818243Z] Running install step. 21:05:33 INFO - Running pre-action listener: _resource_record_pre_action 21:05:33 INFO - Running main action method: install 21:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:05:34 INFO - Reading from file tmpfile_stdout 21:05:34 INFO - Detecting whether we're running mozinstall >=1.0... 21:05:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:05:34 INFO - Reading from file tmpfile_stdout 21:05:34 INFO - Output received: 21:05:34 INFO - Usage: mozinstall [options] installer 21:05:34 INFO - Options: 21:05:34 INFO - -h, --help show this help message and exit 21:05:34 INFO - -d DEST, --destination=DEST 21:05:34 INFO - Directory to install application into. [default: 21:05:34 INFO - "/builds/slave/test"] 21:05:34 INFO - --app=APP Application being installed. [default: firefox] 21:05:34 INFO - mkdir: /builds/slave/test/build/application 21:05:34 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'] 21:05:34 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 21:05:50 INFO - Reading from file tmpfile_stdout 21:05:50 INFO - Output received: 21:05:50 INFO - /builds/slave/test/build/application/firefox/firefox 21:05:50 INFO - Running post-action listener: _resource_record_post_action 21:05:50 INFO - [mozharness: 2016-08-10 04:05:50.979166Z] Finished install step (success) 21:05:50 INFO - [mozharness: 2016-08-10 04:05:50.979413Z] Running run-tests step. 21:05:50 INFO - Running pre-action listener: _resource_record_pre_action 21:05:50 INFO - Running main action method: run_tests 21:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:05:50 INFO - Python 2.7.3 21:05:50 INFO - Return code: 0 21:05:50 INFO - grabbing minidump binary from tooltool 21:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:50 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 0x16df3b0>, '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 0x16e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:05:50 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 21:05:50 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 21:05:50 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 21:05:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:05:51 INFO - Return code: 0 21:05:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:05:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:05:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:05:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:05:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:05:51 INFO - Using env: {'DISPLAY': ':0', 21:05:51 INFO - 'HOME': '/home/cltbld', 21:05:51 INFO - 'LANG': 'en_US.UTF-8', 21:05:51 INFO - 'LANGUAGE': 'en_US:en', 21:05:51 INFO - 'LOGNAME': 'cltbld', 21:05:51 INFO - 'MAIL': '/var/mail/cltbld', 21:05:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:05:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:51 INFO - 'MOZ_NO_REMOTE': '1', 21:05:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:51 INFO - 'NO_EM_RESTART': '1', 21:05:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:51 INFO - 'PWD': '/builds/slave/test', 21:05:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:05:51 INFO - 'SHELL': '/bin/bash', 21:05:51 INFO - 'SHLVL': '1', 21:05:51 INFO - 'TERM': 'linux', 21:05:51 INFO - 'TMOUT': '86400', 21:05:51 INFO - 'USER': 'cltbld', 21:05:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584', 21:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:51 INFO - '_': '/tools/buildbot/bin/python'} 21:05:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:05:51 INFO - mozversion application_buildid: 20160809183001 21:05:51 INFO - mozversion application_changeset: 15d404ae1609b59cc09436df4f3a1ed46a57346d 21:05:51 INFO - mozversion application_display_name: Nightly 21:05:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:05:51 INFO - mozversion application_name: Firefox 21:05:51 INFO - mozversion application_remotingname: firefox 21:05:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:05:51 INFO - mozversion application_vendor: Mozilla 21:05:51 INFO - mozversion application_version: 51.0a1 21:05:51 INFO - mozversion platform_buildid: 20160809183001 21:05:51 INFO - mozversion platform_changeset: 15d404ae1609b59cc09436df4f3a1ed46a57346d 21:05:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:05:51 INFO - mozversion platform_version: 51.0a1 21:05:51 INFO - using testdate: 1470801951 21:05:51 INFO - actual date: 1470801951 21:05:51 INFO - starting webserver on 'localhost:59656' 21:05:51 INFO - SUITE-START | Running 2 tests 21:05:51 INFO - TEST-START | dromaeo_css 21:05:51 INFO - operating with platform_type : linux_ 21:05:51 INFO - Initialising browser for dromaeo_css test... 21:05:51 INFO - TEST-INFO | started process 8991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr71hO1/profile http://localhost:59656/getInfo.html) 21:05:55 INFO - PROCESS | 8991 | __metrics Screen width/height:1600/1200 21:05:55 INFO - PROCESS | 8991 | colorDepth:24 21:05:55 INFO - PROCESS | 8991 | Browser inner width/height: 1024/697 21:05:55 INFO - PROCESS | 8991 | __metrics 21:05:55 ERROR - PROCESS | 8991 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:05:56 INFO - TEST-INFO | 8991: exit 0 21:05:56 INFO - Browser initialized. 21:05:56 INFO - Running cycle 1/1 for dromaeo_css test... 21:05:56 INFO - TEST-INFO | started process 9112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr71hO1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:06:08 INFO - PROCESS | 9112 | RSS: Main: 163225600 21:06:08 INFO - PROCESS | 9112 | 21:06:58 INFO - PROCESS | 9112 | 1470802018161 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] 21:09:08 INFO - PROCESS | 9112 | Cycle 1(1): loaded http://localhost:59656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59656/tests/dromaeo/cssquery-ext.html) 21:09:09 INFO - PROCESS | 9112 | RSS: Main: 165847040 21:09:09 INFO - PROCESS | 9112 | 21:12:11 INFO - PROCESS | 9112 | Cycle 1(1): loaded http://localhost:59656/tests/dromaeo/cssquery-ext.html (next: http://localhost:59656/tests/dromaeo/cssquery-jquery.html) 21:12:12 INFO - PROCESS | 9112 | RSS: Main: 165969920 21:12:12 INFO - PROCESS | 9112 | 21:15:14 INFO - PROCESS | 9112 | Cycle 1(1): loaded http://localhost:59656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59656/tests/dromaeo/cssquery-mootools.html) 21:15:14 INFO - PROCESS | 9112 | RSS: Main: 168648704 21:15:14 INFO - PROCESS | 9112 | 21:18:16 INFO - PROCESS | 9112 | Cycle 1(1): loaded http://localhost:59656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59656/tests/dromaeo/cssquery-prototype.html) 21:18:17 INFO - PROCESS | 9112 | RSS: Main: 162820096 21:18:17 INFO - PROCESS | 9112 | 21:21:19 INFO - PROCESS | 9112 | Cycle 1(1): loaded http://localhost:59656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59656/tests/dromaeo/cssquery-yui.html) 21:21:20 INFO - PROCESS | 9112 | RSS: Main: 165687296 21:21:20 INFO - PROCESS | 9112 | 21:24:22 INFO - PROCESS | 9112 | Cycle 1(1): loaded http://localhost:59656/tests/dromaeo/cssquery-yui.html (next: http://localhost:59656/tests/dromaeo/cssquery-dojo.html) 21:24:22 INFO - PROCESS | 9112 | RSS: Main: 168812544 21:24:22 INFO - PROCESS | 9112 | 21:24:22 INFO - PROCESS | 9112 | __start_tp_report 21:24:22 INFO - PROCESS | 9112 | _x_x_mozilla_page_load 21:24:22 INFO - PROCESS | 9112 | _x_x_mozilla_page_load_details 21:24:22 INFO - PROCESS | 9112 | |i|pagename|runs| 21:24:22 INFO - PROCESS | 9112 | |0;dojo.html;3127.5152351385536;3140.230643492345;3176.269458024655;3176.4758814795573;3179.0939582219057;5377.569794416447;5422.75597598108;5489.835304940848;5554.055810512213;5560.555155587554;5378.193271009351;5439.891202175954;5440.9183862242;5479.671219726809;5490.203920431545;4868.683535570194;4973.129702302101;5009.02324046811;5029.547340739333;5035;5002.449730529639;5039.992001599677;5056.696598204101;5066.012127635113;5137.820176293831;4901.632377571678;4937.061958227961;4990.4011518617635;5024.321716568272;5068.290439338495;5005.049040682259;5007.273945277914;5012.473690262543;5017.824376146854;5024.623153263483;4943.431505376891;4968.478309777493;4972.477889821589;4984.102861484931;5043.319151914481;5330.173823057432;5351.491608297206;5477.424870388591;5516.7517461714315;5588.720563971785;5910.408959104098;5913.113033045035;5914.526837852962;5922.674252916088;5926.466618004357;5955.255593050869;5966.820995370146;5967.671778052206;5974.103884417329;5984.581079324449;5390.460953904618;5428.972855135738;5439.456054394568;5470.261514695545;5512.3385193777;5978.4021597839865;6001.699915004232;6001.789937352259;6005.369436209223;6009.06859436788;5742.052561327334;5783.363829978699;5785.913211301834;5795.88408231833;5805.303363596396;5685.971570142123;5728.312602487728;5837.153612726131;5893.6463812171405;5903.911441328383;5608.719564021782;5798.5071268941765;5811.622244554091;5815.621984570989;5826.941730582725;5763.9135412968835;5844.064949608042;5846.766129354778;5848.941510584839;5851.1515830205235;4441.378207051015;4441.689081764245;4464.531224221475;4473.619742321874;4480.731156130642;3959.9010024749036;4051.9392209116886;4061.857834975821;4070.2876996526084;4099.118689481776;5383.892322153613;5487.451254874561;5529.834104976857;5536.474034966672;5557;5864.941350586525;5889.263842019747;5925.081612350093;5949.762009519657;5990.28116625999;5572.749226284827;5573.498385145275;5573.804916827973;5581.525570326487;5583.748731307101;4926.58124059459;5099.286099946011;5141.614378921521;5142.1772516397195;5193.766280517386;6063.696815159225;6079.240094988127;6096.420840020191;6159.353267906895;6177.907331390123;5917.556183286185;5921.467067963904;5943.58394912352;5948.643081415129;5982.521398288213;5948.910766338595;6129.724162412613;6141.723622436912;6147.323794382525;6164.106204600397;5683.062294721325;5691.060974939089;5725.2843394575675;5727.5417966561745;5818.679972601548;5873.148393483007;5880.617759845596;5895.793647222326;5924.289085309791;5926.555508336978;5704.286964129484;5760.8271751847515;5766.106253530709;5766.826995190151;5786.07422812348;5564.360098588552;5708.65748055118;5752.28096487939;5755.02164632022;5851.1515830205235;5717.914231286617;5731.398203188772;5755.597108202385;5762.7694892203845;5773.364929857797;5771.7402716877;5835.620684655484;5844.386339434298;5851.707414629166;5857.121431785266;5518.917216241679;5587.357453892854;5594.776208951596;5596;5612.326520817528 21:24:22 INFO - PROCESS | 9112 | |1;ext.html;536.0195081929853;565.8330792416236;582.2227326519097;596.3529570416098;625.3340192694777;39679.80160099199;44556.88607784807;44645.776771116136;44660.33009504852;44661;44601;44907.77546112273;44980.3252951206;45048.77475612617;45089.7745511272;8784.472931624106;8842.955785221066;8865.06916773739;8923.330750193729;8934.195922366986;8841.778955526099;8925.062868398822;8956.641734330618;8978.685745998891;8988.415752976069;8760.036395996436;8772.342074344419;8774.736757897273;8777.95611021944;8777.95611021944;8875.423097498642;8963.775905602379;9014.954925225398;9018.729438116801;9019.954900225523;8874.911250887473;8884.8667269991;8947.64209431622;8949.328800340001;8951.910480895172;40804.59195408037;40895.59104408947;41182.79408602968;41210.1757964842;41293.793531032454;3576.177479179777;3754.399296112636;3789.2042671039117;3839.9232015359817;4102.384642303648;33003.17492062694;33122;33280.500792488136;33623.49564756531;34785.13037174091;4416.40378548895;4422.469303683546;4423.380726698265;4455.9554404456185;4490.146872094324;356034;356389;357028;357341;358775;35257.64742352595;55827;56129.71935140298;56251;56253.7187314069;36147.4577881332;36546.451803222975;36600;36864.81567592145;36914.261714765555;13657.385417656229;13789.241591712553;13850.515231966832;13850.515231966832;13862.57404954129;10636.680899573024;10639.787204255872;10647.094996925349;10677.359358438518;10693.144548436107;8607.440516366416;8639.568021598894;8651.697190598425;8664.913350866536;8694.347923905732;3362.5460562823705;3371.140359208386;3407.863685452554;3453.240287136826;3487.9651203487642;1001.484235618657;1024.959001639926;1115.3270094857714;1124.7525544380223;1131.7793030359;27663.30841728973;27896.302592435353;28140.71859281422;28201.858990704914;28473.57289640657;1054.3041592548882;1100.3287994323457;1103.178132291448;1123.0678536814423;1164.7728692904802;14619.342129604192;14887.404503819942;14894.180820055;14948.925255373872;15090.24548772557;559994.6000809991;562449;562885;563020;565673;57535;57687;57823;57900.71049644809;58150.76643102141;1317.2491679742645;1352.2022007015908;1352.8985326100583;1371.6296599917966;1382.3019375215451;26911.596326054732;27025.729742702322;27451;27561.724382755914;27889;50336.49663503318;50422;50678.74660626821;50709.74645126751;50783.492165079355;366933;367869;368098;368401;369144;27990.160295191177;28246;28499.857500712365;28612.141635750962;28763;47309.52690473189;47637.76181119211;48125.518744813504;48272.75863620659;48344.516554834;39769.2046159081;39883.40174897321;39973.40039899462;40813.795931020155;41582.37626435545;39206.215875682894;40690;40845;41154.79422602987;41677.58322416737;40569.1886162281;40986.79506602448;41015.38476922789;41871;41954.580454195064;32763.508547372287;38188.2362352757;38306;38924.6107538921;39842;28524;28620.57069144006;28903.7109628901;29028.56457153102;29260.414791704472 21:24:22 INFO - PROCESS | 9112 | |2;jquery.html;392.2703770985964;402.8207447685781;402.98388064477416;410.9219248342816;422.39175587154494;13719.725605487884;18281.177347019384;18635.62728745424;19749.703754443693;19890.303839365624;18506.352277670285;18833;18947.81052189478;19302.227910883583;19610.313639022635;5715.799947001866;5833.2416785817995;5837.5913686041995;5847.386024467433;5864.472197502224;5757.884842303151;5834.299884013924;5837.270341207349;5841.853953651172;5843.474087332139;5482.205080263359;5725.6278341907855;5755.856103597423;5834.941650583482;5843.094320380348;5744.454276843693;5759.7696092156475;5765.711714414305;5779.104238842986;5811.593188476808;5602.719864006784;5669.603127781057;5764.337101233328;5765.567582431335;5802.912956305659;13984.440622375092;14085.577432677037;14522.346494407777;14568.562943111723;14596.27018649074;2226.1763147635315;2917.168606947031;3014.261505931061;3048.8018278811805;3064.69353064694;11916.940415297868;13691.110077844909;13891.583252502442;14580.052296600687;15236.238188090661;1777.3334999375234;1846.1230915315118;1911.923523059076;1912.3593596145308;1969.3698016634683;79501.60249198775;82858.17141828625;83802.58098709528;86981;88107.55946220292;10900.672979810619;10997.34015959045;11144.721381965515;11379.886201138048;11380.089592832554;15539.766903496457;15569.377224911103;15621;15626.453074142577;15667.2949717263;7554.773356799305;7699.499532530368;7851.803704907309;7852.528848269122;7902;7110.7511237106455;7114.288571142844;7130.215676275606;7347.706091756377;7381.630918454056;4830.275458681226;4870.6103511718975;4899.191633380452;4918.188498897642;4981.750912454363;1999.4401567561106;2016.9814243806784;2045.222815330165;2045.233037610896;2121.734783152106;929.5538141692026;957.9425234485954;988.0958922585897;1005.3515482513737;1062.081299675775;19739.309124180585;19769.901150494155;19793.40619781409;19927.60144797096;20011.699824502644;1004.864343313658;1008.6570566007592;1024.3444195714599;1038.8389799581078;1046.1160319530138;10566.947165264124;11062.170337224741;11110.000099991039;11134.221709144811;11188.272762270426;515255;516038;516611;519970;521192;87404.5629771847;88376.558117209;89805.55097224472;101562;102917;992.9982171847466;1014.9086582207636;1032.3238278927315;1039.9376037437778;1045.5608644369383;15441.691166176839;16125.75811362807;17455.214515347096;18195.45413637593;18279.725804113215;42114.789426052674;42796;43115.7844210777;45166;45327.32009019933;60585;60623;61172.94135293306;62726.37273627205;63688;8094.352451803724;8274.213949674771;8361.540115293474;8435.15648435176;8730.607122679368;9353.953230233805;11073.889261107608;11706.180567360203;11977.760444790882;12402.81395779082;10942.288751231144;10989.890101099207;10995.890041099487;11194.720131996439;11249.887501125211;10494.632687856194;10504.264701470824;10847.186461015297;10863.511141998788;10889.727756806144;10596.15230781551;10661.840072399076;10672.733181670521;10995.615153469591;11142.442877855912;7502.249775022454;8170.264676178935;8294.129116442688;8304.958475207586;8478.74563763088;9471.337006409762;10304.845427318447;10601.840972385575;10659.467026648792;10869.184811139354 21:24:22 INFO - PROCESS | 9112 | |3;mootools.html;1486.7249558831613;1496.6108811708955;1682.3270691723317;1813.1568820498464;1820.2536959846466;8018.158093400197;8489.872651910218;8834.823303533942;9134.543272836365;9161.725148245556;8919.732408027754;8986.550672466383;9012.143846334604;9015.459072455656;9038.18656320931;2382.761723827616;2430.647556104364;2436.074291769134;2439.951200975979;2443.035001174535;2410.4696966667393;2426.4297889995923;2427.1262345555588;2431.2098567965395;2432.5013372258645;2382.833201675883;2403.267003563912;2431.4529230923076;2435.3181109289426;2437.0617312334703;2383.5828729972272;2388.235764555343;2392.940176495584;2399.616061430163;2400.84394514356;2328.5342931413784;2331.4754180309465;2347.917822876191;2348.121502797772;2361.409647588103;8828;8841.292696584322;8852.336074794352;8884.333674974338;8885.689000885002;5370.060239458079;5467.097928841776;5511;5517.475839795213;5538.833834984957;3420.4185288500767;3459.031471188046;3470.8264586770815;3487.2153765402836;3533.0460775590705;1077.4343469678481;1084.2897901874285;1102.2504696806168;1103.7902798468265;1115;12373.13388062836;12414.255144691348;12481.251124932533;12496.375181240901;12536.059795515373;4771.165046116985;4784.40194975628;4836.709797412166;4955.876103097379;4956.306117143603;10537.420441875616;10559.788804223872;10579.84130238047;10597.89402105969;10629.89370106289;5466.9179962300595;5489.752961116679;5530.972345138249;5535.916961245584;5535.944640553624;4390.7585082820115;4903.950960490421;5014.222795466709;5036.143855544567;5050.4949505049935;4087.8364865405647;4099.904144182752;4164.7709375984;4177.97911010443;4182.142660754538;1267.6894160930447;1274.8215249865027;1278.859325474197;1337.5385492005244;1344.2203521957242;891.3493150000536;1006.104566935428;1026.7843752811843;1036.6682661548382;1041.0890470838017;6022.608530445507;6072.180255665517;6282.654454004982;6301.7164227608955;6389.712462939179;467.96256299495957;471.23894909720553;479.87043498255974;481.0547274605417;488.655497873998;4364.738115713068;4380.69335146543;4404.9119017620105;4406.581374769392;4429.202743506135;10727.946360268148;10991;11085.334879907232;11194.992450679478;11197.888021119847;10480.790384192274;11026.283291586022;11085.72285692848;11087;11105.444727763579;8223.342132629496;8344.541050242295;8394.328453723687;8443.95778021106;8450.746477605682;6192.572310797801;6216.751329946932;6232.501399887908;6237.407446292595;6467.126937863516;10364.637237696645;10372.27394082407;10400.167986560906;10436.843447348449;10519.26365154432;9934.751631209278;10185.74535636615;10267.024632659886;10463.424511651932;10513.106385957279;7171.533850299714;7762.961185194264;7916.218850758533;7996.360291176576;8187.877181842158;8848.601812918563;8991.010988791359;8994.100589940954;8997.730068097968;9000.594973226089;7930.762077137695;8052.275295223458;8074.273315401642;8181.976556083769;8319.084900660802;7786.299233069051;7841.607919604111;7868.347646993966;7978.680852765824;8098.635561399633;6907.792766217021;7190.928090719235;7315.451341149329;7316.487845850739;7376.815579610553;5256.369235691742;5283.365996080495;5319.813806516753;5348.545373643284;5529.30883639545;5341.5981942210265;5485.451454854483;5551.500364967173;5588.608797384144;5591.412901645432 21:24:22 INFO - PROCESS | 9112 | |4;prototype.html;341.40765771386657;343.8590178027009;346.3775910474716;351.8733256027831;353.31985927090363;5566.693831839248;5637.915431268534;5718.199452076713;5727.312722473303;5766.82699519014;5534.920690465361;5577.944220557793;5590.133529302964;5596.832095037145;5662.773489060443;3885.49488566486;4134.855280065199;4260.637845783112;4295.484541854982;4304.849330273441;4313.7705753860155;4322;4325.74045557266;4328.805203765823;4343.109662519176;4288.571142885718;4301.8064187111495;4311.698181127323;4320.96296888746;4339.717918335314;4250.91498170038;4269.765162916038;4277.743335399886;4335.913281734363;4336.002719374545;3764;3769.7738135711943;3770.4344348347695;3777.3946072919175;3800.9737370909697;5435.211894275308;5450.400455949843;5460.453954604547;5477.698726570037;5487.149491828773;4815;4940.802367905279;4989.7525618595355;4996.2755400467095;5015.598752099823;5740.885182296331;5769.855753606152;5771.499410153348;5773.9422605773825;5831.271091113611;4075.2257071156682;4112.670986321087;4120.381942708587;4149.460570125894;4175.144095460454;5820.708964551755;6038.071535305374;6048.69756512177;6121.898058349495;6140.846478838065;4313.892152696208;4315.719478233905;4316.482022157361;4331.177076355482;4333.653307735373;4371.9944412785235;4377.759223242752;4379.3649920761945;4379.912401751947;4384.210842048462;4715.929261061086;4973.850784476472;5000.948851889182;5013.423456302572;5019.945811379651;5802.912956305659;5860.912086318709;5862.384449632812;5875.23621929155;5961.135635332939;1476.158589603937;1497.7828214908996;1500.1524138861507;1500.7973923520403;1502.4290769507518;897.582624079806;950.9476978766235;951.653410424242;960.1550635440767;967.2842096848423;4841.249606310957;4882.509919940856;4890.992039895439;4920.40955085392;4926.965337279212;5271.578273738169;5300.6024548158275;5303.549198318109;5319.707416092075;5321.36143662763;4648.5119062498625;4943.393397145942;4954.355933728592;4978.701277923336;4998.250262460588;2764.654418197725;2794.9099851058104;2797.9020734274204;2802.8738706758245;2815.7747380209944;5409.107497262986;5428;5429.4299098594865;5437.8368648940595;5442.510174084351;5133.613924240434;5306.230596563477;5349.759260833272;5364.559125597922;5959.910601340984;6203.565750397519;6211.534134939807;6227.941249987513;6271.27880293763;6284.711634114996;6058.787942421994;6077.969610151921;6130.601510901777;6148.16999705052;6158.538109641884;5868.2077919482035;5967;5976.8804623908145;5979.671118088547;6031;6244.063390491463;6259.78090766821;6285.308616052139;6290.465310448663;6318.462930650946;4135.338345864648;4220;4235.534091250021;4246.278132717383;4276.187524370484;5982.012967860254;5987.88024239504;5991.940080599138;6044.607100538451;6046.818595442144;5832.795852145155;5854.795082172103;5872.941270587239;5894.115882617642;5910.290765108214;5545.279113715191;5776.191333213437;5842.444967728059;5857.560682948711;5893.5874488785375;5828.173335932154;5844.626512769581;5875.764969401176;5875.853103672443;5892.911606325994;5706.942930570807;5864.44287792659;5894.233749612523;5996.160537524663;6017.729202185825;5717;5750.597458177887;5764.193012978102;5767.9134812977;5792.420757924174 21:24:22 INFO - PROCESS | 9112 | |5;yui.html;754.5962909843234;758.3364556013488;800.0319613267945;829.3448175941005;872.0799556467932;15558.144302063396;16757.664846703057;16790.328386864527;16792.160391980397;16795.664086718258;15141.31864066117;15353.923230383833;15365.92317038416;15403.229838508087;15404.460843870467;654.4175683641563;779.0923574036269;795.0340336491176;807.6688557691348;807.7213361390311;808.4421748993205;809.2635701511625;810.8256724804166;814.1695470619964;815.4699445360504;860.9612567434449;860.9612567434449;862.6290695001147;864.6584599083359;869.3740506835101;852.6504133305377;858.8711693246;859.3898332184157;862.1766213266316;862.3489265604428;631.2298995225817;632.1402892066785;632.7816903168399;633.8542135308859;635.044258391123;13722.931385343109;13849.792253116211;13855.584332469942;13856.030077894551;13860.861391386057;15126.470573529874;15719.764203536955;16066.036037837766;16071.758923616155;16251.349946002145;12683.74632507354;12688.566472322049;12731.61805145838;12832.80750788739;12932.35338233094;3867.3812190049457;3959.4456776051375;3969.622885825842;4029.9194016119804;4041.090754580225;82157;85511.57244213739;85769;86190;86192.56903715504;11479.655610331703;11699;11740.589079382351;11877.762444751057;11918.046556275478;23294.184703535295;23351.532969340857;23355.416114597272;23551.646725299135;23583.882080589487;8814.118588141135;8842.646294148291;8896.46621202717;8941.329400294873;9341.439513629204;4508.18852606534;4780.402449693788;4832.275158726219;4884.145274576935;4904.2643603459055;3561.8753343633366;3643.4534819777246;3683.355412802802;3694.242680250542;3698.3712768829364;580.3558050563871;587.823652904127;590.462678962151;604.73089475184;613.8035828534915;673.4780545077506;722.5231347310855;739.0588130537303;757.0763668324745;770.1989930472358;9223.584938677775;9913.157381622643;9929.404235745878;10299.073083422529;10529.473526323653;673.3064943108508;734.3354264390734;778.5756762564416;790.3992965346263;810.5906517208772;4444.777761111932;4753.073150735642;4782.95217047832;4840.903181936342;4919.803207871645;71574.64212679007;71654.2834571658;71798.64100679463;116122.8387716129;120670;103812.48093759634;105022;107224.46387768011;107813;108620;56595.717021415454;95711;95816.52091739497;98370;98462.50768746111;9165.633374665205;9235.953820230856;9541.332106752461;10084.294099413264;10152.847707284544;51116.74441627768;53468.73265633647;54646;55029;55071.72464137814;52864.73567632291;56503.15245271242;77214;78378.6081069591;79767;12800.35998200105;13002.154859934075;13058.15122017066;13099.738005240033;13305;14441.422343106158;14526.491572794901;14549.563513094625;15152.469663561722;15550.455734049254;14271.928640356731;14369.209693466959;14654.63363415923;14779.778303325244;14957.326920288831;13942.512012079529;14063.789043164565;14130.222837744022;14546.272686365428;14804.481843135438;14684.265786710408;14986.175760333286;15017.399304027716;15466.458673946358;15850.52448426549;11084.279521831055;11424.428778560872;11444;11564.826527601925;11827.526898923947;11893.166606390154;12181.573644922386;12311.69220769488;12345.567905123278;12397.504099836266 21:24:22 INFO - PROCESS | 9112 | __end_tp_report 21:24:22 INFO - PROCESS | 9112 | __start_cc_report 21:24:22 INFO - PROCESS | 9112 | _x_x_mozilla_cycle_collect,308 21:24:22 INFO - PROCESS | 9112 | __end_cc_report 21:24:22 INFO - PROCESS | 9112 | __startTimestamp1470803062887__endTimestamp 21:24:22 INFO - PROCESS | 9112 | 21:24:22 INFO - PROCESS | 9112 | ------- Summary: start ------- 21:24:22 INFO - PROCESS | 9112 | Number of tests: 6 21:24:22 INFO - PROCESS | 9112 | 21:24:22 INFO - PROCESS | 9112 | [#0] dojo.html Cycles:165 Average:5458.85 Median:5683.06 stddev:623.02 (11.0%) stddev-sans-first:597.48 21:24:22 INFO - PROCESS | 9112 | Values: 3127.5 3140.2 3176.3 3176.5 3179.1 5377.6 5422.8 5489.8 5554.1 5560.6 5378.2 5439.9 5440.9 5479.7 5490.2 4868.7 4973.1 5009.0 5029.5 5035.0 5002.4 5040.0 5056.7 5066.0 5137.8 4901.6 4937.1 4990.4 5024.3 5068.3 5005.0 5007.3 5012.5 5017.8 5024.6 4943.4 4968.5 4972.5 4984.1 5043.3 5330.2 5351.5 5477.4 5516.8 5588.7 5910.4 5913.1 5914.5 5922.7 5926.5 5955.3 5966.8 5967.7 5974.1 5984.6 5390.5 5429.0 5439.5 5470.3 5512.3 5978.4 6001.7 6001.8 6005.4 6009.1 5742.1 5783.4 5785.9 5795.9 5805.3 5686.0 5728.3 5837.2 5893.6 5903.9 5608.7 5798.5 5811.6 5815.6 5826.9 5763.9 5844.1 5846.8 5848.9 5851.2 4441.4 4441.7 4464.5 4473.6 4480.7 3959.9 4051.9 4061.9 4070.3 4099.1 5383.9 5487.5 5529.8 5536.5 5557.0 5864.9 5889.3 5925.1 5949.8 5990.3 5572.7 5573.5 5573.8 5581.5 5583.7 4926.6 5099.3 5141.6 5142.2 5193.8 6063.7 6079.2 6096.4 6159.4 6177.9 5917.6 5921.5 5943.6 5948.6 5982.5 5948.9 6129.7 6141.7 6147.3 6164.1 5683.1 5691.1 5725.3 5727.5 5818.7 5873.1 5880.6 5895.8 5924.3 5926.6 5704.3 5760.8 5766.1 5766.8 5786.1 5564.4 5708.7 5752.3 5755.0 5851.2 5717.9 5731.4 5755.6 5762.8 5773.4 5771.7 5835.6 5844.4 5851.7 5857.1 5518.9 5587.4 5594.8 5596.0 5612.3 21:24:22 INFO - PROCESS | 9112 | 21:24:22 INFO - PROCESS | 9112 | [#1] ext.html Cycles:180 Average:57698.01 Median:40629.59 stddev:116946.51 (287.8%) stddev-sans-first:117195.82 21:24:22 INFO - PROCESS | 9112 | Values: 536.0 565.8 582.2 596.4 625.3 39679.8 44556.9 44645.8 44660.3 44661.0 44601.0 44907.8 44980.3 45048.8 45089.8 8784.5 8843.0 8865.1 8923.3 8934.2 8841.8 8925.1 8956.6 8978.7 8988.4 8760.0 8772.3 8774.7 8778.0 8778.0 8875.4 8963.8 9015.0 9018.7 9020.0 8874.9 8884.9 8947.6 8949.3 8951.9 40804.6 40895.6 41182.8 41210.2 41293.8 3576.2 3754.4 3789.2 3839.9 4102.4 33003.2 33122.0 33280.5 33623.5 34785.1 4416.4 4422.5 4423.4 4456.0 4490.1 356034.0 356389.0 357028.0 357341.0 358775.0 35257.6 55827.0 56129.7 56251.0 56253.7 36147.5 36546.5 36600.0 36864.8 36914.3 13657.4 13789.2 13850.5 13850.5 13862.6 10636.7 10639.8 10647.1 10677.4 10693.1 8607.4 8639.6 8651.7 8664.9 8694.3 3362.5 3371.1 3407.9 3453.2 3488.0 1001.5 1025.0 1115.3 1124.8 1131.8 27663.3 27896.3 28140.7 28201.9 28473.6 1054.3 1100.3 1103.2 1123.1 1164.8 14619.3 14887.4 14894.2 14948.9 15090.2 559994.6 562449.0 562885.0 563020.0 565673.0 57535.0 57687.0 57823.0 57900.7 58150.8 1317.2 1352.2 1352.9 1371.6 1382.3 26911.6 27025.7 27451.0 27561.7 27889.0 50336.5 50422.0 50678.7 50709.7 50783.5 366933.0 367869.0 368098.0 368401.0 369144.0 27990.2 28246.0 28499.9 28612.1 28763.0 47309.5 47637.8 48125.5 48272.8 48344.5 39769.2 39883.4 39973.4 40813.8 41582.4 39206.2 40690.0 40845.0 41154.8 41677.6 40569.2 40986.8 41015.4 41871.0 41954.6 32763.5 38188.2 38306.0 38924.6 39842.0 28524.0 28620.6 28903.7 29028.6 29260.4 21:24:22 INFO - PROCESS | 9112 | 21:24:22 INFO - PROCESS | 9112 | [#2] jquery.html Cycles:180 Average:29760.50 Median:2173.96 stddev:85432.11 (3929.8%) stddev-sans-first:85643.31 21:24:22 INFO - PROCESS | 9112 | Values: 392.3 402.8 403.0 410.9 422.4 13719.7 18281.2 18635.6 19749.7 19890.3 18506.4 18833.0 18947.8 19302.2 19610.3 5715.8 5833.2 5837.6 5847.4 5864.5 5757.9 5834.3 5837.3 5841.9 5843.5 5482.2 5725.6 5755.9 5834.9 5843.1 5744.5 5759.8 5765.7 5779.1 5811.6 5602.7 5669.6 5764.3 5765.6 5802.9 13984.4 14085.6 14522.3 14568.6 14596.3 2226.2 2917.2 3014.3 3048.8 3064.7 11916.9 13691.1 13891.6 14580.1 15236.2 1777.3 1846.1 1911.9 1912.4 1969.4 79501.6 82858.2 83802.6 86981.0 88107.6 10900.7 10997.3 11144.7 11379.9 11380.1 15539.8 15569.4 15621.0 15626.5 15667.3 7554.8 7699.5 7851.8 7852.5 7902.0 7110.8 7114.3 7130.2 7347.7 7381.6 4830.3 4870.6 4899.2 4918.2 4981.8 1999.4 2017.0 2045.2 2045.2 2121.7 929.6 957.9 988.1 1005.4 1062.1 19739.3 19769.9 19793.4 19927.6 20011.7 1004.9 1008.7 1024.3 1038.8 1046.1 10566.9 11062.2 11110.0 11134.2 11188.3 515255.0 516038.0 516611.0 519970.0 521192.0 87404.6 88376.6 89805.6 101562.0 102917.0 993.0 1014.9 1032.3 1039.9 1045.6 15441.7 16125.8 17455.2 18195.5 18279.7 42114.8 42796.0 43115.8 45166.0 45327.3 60585.0 60623.0 61172.9 62726.4 63688.0 8094.4 8274.2 8361.5 8435.2 8730.6 9354.0 11073.9 11706.2 11977.8 12402.8 10942.3 10989.9 10995.9 11194.7 11249.9 10494.6 10504.3 10847.2 10863.5 10889.7 10596.2 10661.8 10672.7 10995.6 11142.4 7502.2 8170.3 8294.1 8305.0 8478.7 9471.3 10304.8 10601.8 10659.5 10869.2 21:24:22 INFO - PROCESS | 9112 | 21:24:22 INFO - PROCESS | 9112 | [#3] mootools.html Cycles:180 Average:5953.69 Median:2621.20 stddev:3360.96 (128.2%) stddev-sans-first:3353.62 21:24:22 INFO - PROCESS | 9112 | Values: 1486.7 1496.6 1682.3 1813.2 1820.3 8018.2 8489.9 8834.8 9134.5 9161.7 8919.7 8986.6 9012.1 9015.5 9038.2 2382.8 2430.6 2436.1 2440.0 2443.0 2410.5 2426.4 2427.1 2431.2 2432.5 2382.8 2403.3 2431.5 2435.3 2437.1 2383.6 2388.2 2392.9 2399.6 2400.8 2328.5 2331.5 2347.9 2348.1 2361.4 8828.0 8841.3 8852.3 8884.3 8885.7 5370.1 5467.1 5511.0 5517.5 5538.8 3420.4 3459.0 3470.8 3487.2 3533.0 1077.4 1084.3 1102.3 1103.8 1115.0 12373.1 12414.3 12481.3 12496.4 12536.1 4771.2 4784.4 4836.7 4955.9 4956.3 10537.4 10559.8 10579.8 10597.9 10629.9 5466.9 5489.8 5531.0 5535.9 5535.9 4390.8 4904.0 5014.2 5036.1 5050.5 4087.8 4099.9 4164.8 4178.0 4182.1 1267.7 1274.8 1278.9 1337.5 1344.2 891.3 1006.1 1026.8 1036.7 1041.1 6022.6 6072.2 6282.7 6301.7 6389.7 468.0 471.2 479.9 481.1 488.7 4364.7 4380.7 4404.9 4406.6 4429.2 10727.9 10991.0 11085.3 11195.0 11197.9 10480.8 11026.3 11085.7 11087.0 11105.4 8223.3 8344.5 8394.3 8444.0 8450.7 6192.6 6216.8 6232.5 6237.4 6467.1 10364.6 10372.3 10400.2 10436.8 10519.3 9934.8 10185.7 10267.0 10463.4 10513.1 7171.5 7763.0 7916.2 7996.4 8187.9 8848.6 8991.0 8994.1 8997.7 9000.6 7930.8 8052.3 8074.3 8182.0 8319.1 7786.3 7841.6 7868.3 7978.7 8098.6 6907.8 7190.9 7315.5 7316.5 7376.8 5256.4 5283.4 5319.8 5348.5 5529.3 5341.6 5485.5 5551.5 5588.6 5591.4 21:24:22 INFO - PROCESS | 9112 | 21:24:22 INFO - PROCESS | 9112 | [#4] prototype.html Cycles:180 Average:4821.50 Median:5428.71 stddev:1436.91 (26.5%) stddev-sans-first:1401.04 21:24:22 INFO - PROCESS | 9112 | Values: 341.4 343.9 346.4 351.9 353.3 5566.7 5637.9 5718.2 5727.3 5766.8 5534.9 5577.9 5590.1 5596.8 5662.8 3885.5 4134.9 4260.6 4295.5 4304.8 4313.8 4322.0 4325.7 4328.8 4343.1 4288.6 4301.8 4311.7 4321.0 4339.7 4250.9 4269.8 4277.7 4335.9 4336.0 3764.0 3769.8 3770.4 3777.4 3801.0 5435.2 5450.4 5460.5 5477.7 5487.1 4815.0 4940.8 4989.8 4996.3 5015.6 5740.9 5769.9 5771.5 5773.9 5831.3 4075.2 4112.7 4120.4 4149.5 4175.1 5820.7 6038.1 6048.7 6121.9 6140.8 4313.9 4315.7 4316.5 4331.2 4333.7 4372.0 4377.8 4379.4 4379.9 4384.2 4715.9 4973.9 5000.9 5013.4 5019.9 5802.9 5860.9 5862.4 5875.2 5961.1 1476.2 1497.8 1500.2 1500.8 1502.4 897.6 950.9 951.7 960.2 967.3 4841.2 4882.5 4891.0 4920.4 4927.0 5271.6 5300.6 5303.5 5319.7 5321.4 4648.5 4943.4 4954.4 4978.7 4998.3 2764.7 2794.9 2797.9 2802.9 2815.8 5409.1 5428.0 5429.4 5437.8 5442.5 5133.6 5306.2 5349.8 5364.6 5959.9 6203.6 6211.5 6227.9 6271.3 6284.7 6058.8 6078.0 6130.6 6148.2 6158.5 5868.2 5967.0 5976.9 5979.7 6031.0 6244.1 6259.8 6285.3 6290.5 6318.5 4135.3 4220.0 4235.5 4246.3 4276.2 5982.0 5987.9 5991.9 6044.6 6046.8 5832.8 5854.8 5872.9 5894.1 5910.3 5545.3 5776.2 5842.4 5857.6 5893.6 5828.2 5844.6 5875.8 5875.9 5892.9 5706.9 5864.4 5894.2 5996.2 6017.7 5717.0 5750.6 5764.2 5767.9 5792.4 21:24:22 INFO - PROCESS | 9112 | 21:24:22 INFO - PROCESS | 9112 | [#5] yui.html Cycles:180 Average:20877.39 Median:4242.93 stddev:29452.48 (694.2%) stddev-sans-first:29496.34 21:24:22 INFO - PROCESS | 9112 | Values: 754.6 758.3 800.0 829.3 872.1 15558.1 16757.7 16790.3 16792.2 16795.7 15141.3 15353.9 15365.9 15403.2 15404.5 654.4 779.1 795.0 807.7 807.7 808.4 809.3 810.8 814.2 815.5 861.0 861.0 862.6 864.7 869.4 852.7 858.9 859.4 862.2 862.3 631.2 632.1 632.8 633.9 635.0 13722.9 13849.8 13855.6 13856.0 13860.9 15126.5 15719.8 16066.0 16071.8 16251.3 12683.7 12688.6 12731.6 12832.8 12932.4 3867.4 3959.4 3969.6 4029.9 4041.1 82157.0 85511.6 85769.0 86190.0 86192.6 11479.7 11699.0 11740.6 11877.8 11918.0 23294.2 23351.5 23355.4 23551.6 23583.9 8814.1 8842.6 8896.5 8941.3 9341.4 4508.2 4780.4 4832.3 4884.1 4904.3 3561.9 3643.5 3683.4 3694.2 3698.4 580.4 587.8 590.5 604.7 613.8 673.5 722.5 739.1 757.1 770.2 9223.6 9913.2 9929.4 10299.1 10529.5 673.3 734.3 778.6 790.4 810.6 4444.8 4753.1 4783.0 4840.9 4919.8 71574.6 71654.3 71798.6 116122.8 120670.0 103812.5 105022.0 107224.5 107813.0 108620.0 56595.7 95711.0 95816.5 98370.0 98462.5 9165.6 9236.0 9541.3 10084.3 10152.8 51116.7 53468.7 54646.0 55029.0 55071.7 52864.7 56503.2 77214.0 78378.6 79767.0 12800.4 13002.2 13058.2 13099.7 13305.0 14441.4 14526.5 14549.6 15152.5 15550.5 14271.9 14369.2 14654.6 14779.8 14957.3 13942.5 14063.8 14130.2 14546.3 14804.5 14684.3 14986.2 15017.4 15466.5 15850.5 11084.3 11424.4 11444.0 11564.8 11827.5 11893.2 12181.6 12311.7 12345.6 12397.5 21:24:22 INFO - PROCESS | 9112 | -------- Summary: end -------- 21:24:22 INFO - PROCESS | 9112 | 21:24:23 INFO - TEST-INFO | 9112: exit 0 21:24:23 INFO - TEST-OK | dromaeo_css | took 1112417ms 21:24:23 INFO - TEST-START | kraken 21:24:23 INFO - operating with platform_type : linux_ 21:24:23 INFO - Initialising browser for kraken test... 21:24:23 INFO - TEST-INFO | started process 9366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJ0zfJ/profile http://localhost:59656/getInfo.html) 21:24:27 INFO - PROCESS | 9366 | __metrics Screen width/height:1600/1200 21:24:27 INFO - PROCESS | 9366 | colorDepth:24 21:24:27 INFO - PROCESS | 9366 | Browser inner width/height: 1024/697 21:24:27 INFO - PROCESS | 9366 | __metrics 21:24:28 ERROR - PROCESS | 9366 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:24:29 INFO - TEST-INFO | 9366: exit 0 21:24:29 INFO - Browser initialized. 21:24:29 INFO - Running cycle 1/1 for kraken test... 21:24:29 INFO - TEST-INFO | started process 9489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJ0zfJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:24:41 INFO - PROCESS | 9489 | RSS: Main: 163045376 21:24:41 INFO - PROCESS | 9489 | 21:24:43 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59656/tests/kraken/driver.html?testName=audio-beat-detection) 21:24:44 INFO - PROCESS | 9489 | RSS: Main: 168378368 21:24:44 INFO - PROCESS | 9489 | 21:24:47 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59656/tests/kraken/driver.html?testName=audio-dft) 21:24:47 INFO - PROCESS | 9489 | RSS: Main: 167821312 21:24:47 INFO - PROCESS | 9489 | 21:24:50 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59656/tests/kraken/driver.html?testName=audio-fft) 21:24:51 INFO - PROCESS | 9489 | RSS: Main: 163061760 21:24:51 INFO - PROCESS | 9489 | 21:24:53 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59656/tests/kraken/driver.html?testName=audio-oscillator) 21:24:54 INFO - PROCESS | 9489 | RSS: Main: 164745216 21:24:54 INFO - PROCESS | 9489 | 21:24:56 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:24:56 INFO - PROCESS | 9489 | RSS: Main: 164831232 21:24:56 INFO - PROCESS | 9489 | 21:25:00 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59656/tests/kraken/driver.html?testName=imaging-darkroom) 21:25:00 INFO - PROCESS | 9489 | RSS: Main: 164933632 21:25:00 INFO - PROCESS | 9489 | 21:25:04 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59656/tests/kraken/driver.html?testName=imaging-desaturate) 21:25:04 INFO - PROCESS | 9489 | RSS: Main: 162107392 21:25:04 INFO - PROCESS | 9489 | 21:25:07 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59656/tests/kraken/driver.html?testName=json-parse-financial) 21:25:08 INFO - PROCESS | 9489 | RSS: Main: 164237312 21:25:08 INFO - PROCESS | 9489 | 21:25:09 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:25:10 INFO - PROCESS | 9489 | RSS: Main: 163954688 21:25:10 INFO - PROCESS | 9489 | 21:25:12 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59656/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:25:12 INFO - PROCESS | 9489 | RSS: Main: 164061184 21:25:12 INFO - PROCESS | 9489 | 21:25:14 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:25:15 INFO - PROCESS | 9489 | RSS: Main: 164646912 21:25:15 INFO - PROCESS | 9489 | 21:25:18 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:25:18 INFO - PROCESS | 9489 | RSS: Main: 164765696 21:25:18 INFO - PROCESS | 9489 | 21:25:21 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:25:22 INFO - PROCESS | 9489 | RSS: Main: 165269504 21:25:22 INFO - PROCESS | 9489 | 21:25:23 INFO - PROCESS | 9489 | Cycle 1(1): loaded http://localhost:59656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59656/tests/kraken/driver.html?testName=ai-astar) 21:25:24 INFO - PROCESS | 9489 | RSS: Main: 166154240 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | __start_tp_report 21:25:24 INFO - PROCESS | 9489 | _x_x_mozilla_page_load 21:25:24 INFO - PROCESS | 9489 | _x_x_mozilla_page_load_details 21:25:24 INFO - PROCESS | 9489 | |i|pagename|runs| 21:25:24 INFO - PROCESS | 9489 | |0;ai-astar;103;113;107;115;113;114;114;114;113;112 21:25:24 INFO - PROCESS | 9489 | |1;audio-beat-detection;149;120;148;171;125;147;143;120;170;119 21:25:24 INFO - PROCESS | 9489 | |2;audio-dft;162;163;163;163;163;177;164;165;162;162 21:25:24 INFO - PROCESS | 9489 | |3;audio-fft;74;75;76;180;78;76;76;75;179;78 21:25:24 INFO - PROCESS | 9489 | |4;audio-oscillator;85;85;158;86;85;85;142;84;84;149 21:25:24 INFO - PROCESS | 9489 | |5;imaging-gaussian-blur;117;119;119;118;117;118;118;118;117;117 21:25:24 INFO - PROCESS | 9489 | |6;imaging-darkroom;146;147;148;146;147;147;148;147;148;148 21:25:24 INFO - PROCESS | 9489 | |7;imaging-desaturate;97;95;95;98;96;95;96;97;97;96 21:25:24 INFO - PROCESS | 9489 | |8;json-parse-financial;50;51;52;50;54;54;52;50;50;51 21:25:24 INFO - PROCESS | 9489 | |9;json-stringify-tinderbox;62;64;63;63;64;63;63;63;64;62 21:25:24 INFO - PROCESS | 9489 | |10;stanford-crypto-aes;81;80;79;76;82;76;76;86;81;76 21:25:24 INFO - PROCESS | 9489 | |11;stanford-crypto-ccm;130;122;138;122;128;126;143;126;189;124 21:25:24 INFO - PROCESS | 9489 | |12;stanford-crypto-pbkdf2;160;157;158;156;161;160;162;157;160;156 21:25:24 INFO - PROCESS | 9489 | |13;stanford-crypto-sha256-iterative;65;63;64;67;65;63;65;66;64;62 21:25:24 INFO - PROCESS | 9489 | __end_tp_report 21:25:24 INFO - PROCESS | 9489 | __start_cc_report 21:25:24 INFO - PROCESS | 9489 | _x_x_mozilla_cycle_collect,875 21:25:24 INFO - PROCESS | 9489 | __end_cc_report 21:25:24 INFO - PROCESS | 9489 | __startTimestamp1470803124201__endTimestamp 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | ------- Summary: start ------- 21:25:24 INFO - PROCESS | 9489 | Number of tests: 14 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:3.79 (3.3%) stddev-sans-first:2.33 21:25:24 INFO - PROCESS | 9489 | Values: 103.0 113.0 107.0 115.0 113.0 114.0 114.0 114.0 113.0 112.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:147.50 stddev:19.76 (13.4%) stddev-sans-first:20.76 21:25:24 INFO - PROCESS | 9489 | Values: 149.0 120.0 148.0 171.0 125.0 147.0 143.0 120.0 170.0 119.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.00 stddev:4.53 (2.8%) stddev-sans-first:4.72 21:25:24 INFO - PROCESS | 9489 | Values: 162.0 163.0 163.0 163.0 163.0 177.0 164.0 165.0 162.0 162.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#3] audio-fft Cycles:10 Average:96.70 Median:76.00 stddev:43.66 (57.4%) stddev-sans-first:45.53 21:25:24 INFO - PROCESS | 9489 | Values: 74.0 75.0 76.0 180.0 78.0 76.0 76.0 75.0 179.0 78.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:85.00 stddev:31.54 (37.1%) stddev-sans-first:32.67 21:25:24 INFO - PROCESS | 9489 | Values: 85.0 85.0 158.0 86.0 85.0 85.0 142.0 84.0 84.0 149.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 21:25:24 INFO - PROCESS | 9489 | Values: 117.0 119.0 119.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 21:25:24 INFO - PROCESS | 9489 | Values: 146.0 147.0 148.0 146.0 147.0 147.0 148.0 147.0 148.0 148.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:1.03 (1.1%) stddev-sans-first:1.05 21:25:24 INFO - PROCESS | 9489 | Values: 97.0 95.0 95.0 98.0 96.0 95.0 96.0 97.0 97.0 96.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.50 stddev:1.58 (3.1%) stddev-sans-first:1.59 21:25:24 INFO - PROCESS | 9489 | Values: 50.0 51.0 52.0 50.0 54.0 54.0 52.0 50.0 50.0 51.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 21:25:24 INFO - PROCESS | 9489 | Values: 62.0 64.0 63.0 63.0 64.0 63.0 63.0 63.0 64.0 62.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:80.50 stddev:3.37 (4.2%) stddev-sans-first:3.52 21:25:24 INFO - PROCESS | 9489 | Values: 81.0 80.0 79.0 76.0 82.0 76.0 76.0 86.0 81.0 76.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:129.00 stddev:20.23 (15.7%) stddev-sans-first:21.38 21:25:24 INFO - PROCESS | 9489 | Values: 130.0 122.0 138.0 122.0 128.0 126.0 143.0 126.0 189.0 124.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:160.00 stddev:2.16 (1.4%) stddev-sans-first:2.24 21:25:24 INFO - PROCESS | 9489 | Values: 160.0 157.0 158.0 156.0 161.0 160.0 162.0 157.0 160.0 156.0 21:25:24 INFO - PROCESS | 9489 | 21:25:24 INFO - PROCESS | 9489 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:1.51 (2.3%) stddev-sans-first:1.58 21:25:24 INFO - PROCESS | 9489 | Values: 65.0 63.0 64.0 67.0 65.0 63.0 65.0 66.0 64.0 62.0 21:25:24 INFO - PROCESS | 9489 | -------- Summary: end -------- 21:25:24 INFO - PROCESS | 9489 | 21:25:25 INFO - TEST-INFO | 9489: exit 0 21:25:25 INFO - TEST-OK | kraken | took 61481ms 21:25:25 INFO - SUITE-END | took 1173s 21:25:25 INFO - Completed test suite (00:19:34) 21:25:25 INFO - javascript benchmark 21:25:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7259.655155987584, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.5152351385536, 3140.230643492345, 3176.269458024655, 3176.4758814795573, 3179.0939582219057, 5377.569794416447, 5422.75597598108, 5489.835304940848, 5554.055810512213, 5560.555155587554, 5378.193271009351, 5439.891202175954, 5440.9183862242, 5479.671219726809, 5490.203920431545, 4868.683535570194, 4973.129702302101, 5009.02324046811, 5029.547340739333, 5035.0, 5002.449730529639, 5039.992001599677, 5056.696598204101, 5066.012127635113, 5137.820176293831, 4901.632377571678, 4937.061958227961, 4990.4011518617635, 5024.321716568272, 5068.290439338495, 5005.049040682259, 5007.273945277914, 5012.473690262543, 5017.824376146854, 5024.623153263483, 4943.431505376891, 4968.478309777493, 4972.477889821589, 4984.102861484931, 5043.319151914481, 5330.173823057432, 5351.491608297206, 5477.424870388591, 5516.7517461714315, 5588.720563971785, 5910.408959104098, 5913.113033045035, 5914.526837852962, 5922.674252916088, 5926.466618004357, 5955.255593050869, 5966.820995370146, 5967.671778052206, 5974.103884417329, 5984.581079324449, 5390.460953904618, 5428.972855135738, 5439.456054394568, 5470.261514695545, 5512.3385193777, 5978.4021597839865, 6001.699915004232, 6001.789937352259, 6005.369436209223, 6009.06859436788, 5742.052561327334, 5783.363829978699, 5785.913211301834, 5795.88408231833, 5805.303363596396, 5685.971570142123, 5728.312602487728, 5837.153612726131, 5893.6463812171405, 5903.911441328383, 5608.719564021782, 5798.5071268941765, 5811.622244554091, 5815.621984570989, 5826.941730582725, 5763.9135412968835, 5844.064949608042, 5846.766129354778, 5848.941510584839, 5851.1515830205235, 4441.378207051015, 4441.689081764245, 4464.531224221475, 4473.619742321874, 4480.731156130642, 3959.9010024749036, 4051.9392209116886, 4061.857834975821, 4070.2876996526084, 4099.118689481776, 5383.892322153613, 5487.451254874561, 5529.834104976857, 5536.474034966672, 5557.0, 5864.941350586525, 5889.263842019747, 5925.081612350093, 5949.762009519657, 5990.28116625999, 5572.749226284827, 5573.498385145275, 5573.804916827973, 5581.525570326487, 5583.748731307101, 4926.58124059459, 5099.286099946011, 5141.614378921521, 5142.1772516397195, 5193.766280517386, 6063.696815159225, 6079.240094988127, 6096.420840020191, 6159.353267906895, 6177.907331390123, 5917.556183286185, 5921.467067963904, 5943.58394912352, 5948.643081415129, 5982.521398288213, 5948.910766338595, 6129.724162412613, 6141.723622436912, 6147.323794382525, 6164.106204600397, 5683.062294721325, 5691.060974939089, 5725.2843394575675, 5727.5417966561745, 5818.679972601548, 5873.148393483007, 5880.617759845596, 5895.793647222326, 5924.289085309791, 5926.555508336978, 5704.286964129484, 5760.8271751847515, 5766.106253530709, 5766.826995190151, 5786.07422812348, 5564.360098588552, 5708.65748055118, 5752.28096487939, 5755.02164632022, 5851.1515830205235, 5717.914231286617, 5731.398203188772, 5755.597108202385, 5762.7694892203845, 5773.364929857797, 5771.7402716877, 5835.620684655484, 5844.386339434298, 5851.707414629166, 5857.121431785266, 5518.917216241679, 5587.357453892854, 5594.776208951596, 5596.0, 5612.326520817528], "value": 5416.554436555426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.0195081929853, 565.8330792416236, 582.2227326519097, 596.3529570416098, 625.3340192694777, 39679.80160099199, 44556.88607784807, 44645.776771116136, 44660.33009504852, 44661.0, 44601.0, 44907.77546112273, 44980.3252951206, 45048.77475612617, 45089.7745511272, 8784.472931624106, 8842.955785221066, 8865.06916773739, 8923.330750193729, 8934.195922366986, 8841.778955526099, 8925.062868398822, 8956.641734330618, 8978.685745998891, 8988.415752976069, 8760.036395996436, 8772.342074344419, 8774.736757897273, 8777.95611021944, 8777.95611021944, 8875.423097498642, 8963.775905602379, 9014.954925225398, 9018.729438116801, 9019.954900225523, 8874.911250887473, 8884.8667269991, 8947.64209431622, 8949.328800340001, 8951.910480895172, 40804.59195408037, 40895.59104408947, 41182.79408602968, 41210.1757964842, 41293.793531032454, 3576.177479179777, 3754.399296112636, 3789.2042671039117, 3839.9232015359817, 4102.384642303648, 33003.17492062694, 33122.0, 33280.500792488136, 33623.49564756531, 34785.13037174091, 4416.40378548895, 4422.469303683546, 4423.380726698265, 4455.9554404456185, 4490.146872094324, 356034.0, 356389.0, 357028.0, 357341.0, 358775.0, 35257.64742352595, 55827.0, 56129.71935140298, 56251.0, 56253.7187314069, 36147.4577881332, 36546.451803222975, 36600.0, 36864.81567592145, 36914.261714765555, 13657.385417656229, 13789.241591712553, 13850.515231966832, 13850.515231966832, 13862.57404954129, 10636.680899573024, 10639.787204255872, 10647.094996925349, 10677.359358438518, 10693.144548436107, 8607.440516366416, 8639.568021598894, 8651.697190598425, 8664.913350866536, 8694.347923905732, 3362.5460562823705, 3371.140359208386, 3407.863685452554, 3453.240287136826, 3487.9651203487642, 1001.484235618657, 1024.959001639926, 1115.3270094857714, 1124.7525544380223, 1131.7793030359, 27663.30841728973, 27896.302592435353, 28140.71859281422, 28201.858990704914, 28473.57289640657, 1054.3041592548882, 1100.3287994323457, 1103.178132291448, 1123.0678536814423, 1164.7728692904802, 14619.342129604192, 14887.404503819942, 14894.180820055, 14948.925255373872, 15090.24548772557, 559994.6000809991, 562449.0, 562885.0, 563020.0, 565673.0, 57535.0, 57687.0, 57823.0, 57900.71049644809, 58150.76643102141, 1317.2491679742645, 1352.2022007015908, 1352.8985326100583, 1371.6296599917966, 1382.3019375215451, 26911.596326054732, 27025.729742702322, 27451.0, 27561.724382755914, 27889.0, 50336.49663503318, 50422.0, 50678.74660626821, 50709.74645126751, 50783.492165079355, 366933.0, 367869.0, 368098.0, 368401.0, 369144.0, 27990.160295191177, 28246.0, 28499.857500712365, 28612.141635750962, 28763.0, 47309.52690473189, 47637.76181119211, 48125.518744813504, 48272.75863620659, 48344.516554834, 39769.2046159081, 39883.40174897321, 39973.40039899462, 40813.795931020155, 41582.37626435545, 39206.215875682894, 40690.0, 40845.0, 41154.79422602987, 41677.58322416737, 40569.1886162281, 40986.79506602448, 41015.38476922789, 41871.0, 41954.580454195064, 32763.508547372287, 38188.2362352757, 38306.0, 38924.6107538921, 39842.0, 28524.0, 28620.57069144006, 28903.7109628901, 29028.56457153102, 29260.414791704472], "value": 18592.463225657713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.2703770985964, 402.8207447685781, 402.98388064477416, 410.9219248342816, 422.39175587154494, 13719.725605487884, 18281.177347019384, 18635.62728745424, 19749.703754443693, 19890.303839365624, 18506.352277670285, 18833.0, 18947.81052189478, 19302.227910883583, 19610.313639022635, 5715.799947001866, 5833.2416785817995, 5837.5913686041995, 5847.386024467433, 5864.472197502224, 5757.884842303151, 5834.299884013924, 5837.270341207349, 5841.853953651172, 5843.474087332139, 5482.205080263359, 5725.6278341907855, 5755.856103597423, 5834.941650583482, 5843.094320380348, 5744.454276843693, 5759.7696092156475, 5765.711714414305, 5779.104238842986, 5811.593188476808, 5602.719864006784, 5669.603127781057, 5764.337101233328, 5765.567582431335, 5802.912956305659, 13984.440622375092, 14085.577432677037, 14522.346494407777, 14568.562943111723, 14596.27018649074, 2226.1763147635315, 2917.168606947031, 3014.261505931061, 3048.8018278811805, 3064.69353064694, 11916.940415297868, 13691.110077844909, 13891.583252502442, 14580.052296600687, 15236.238188090661, 1777.3334999375234, 1846.1230915315118, 1911.923523059076, 1912.3593596145308, 1969.3698016634683, 79501.60249198775, 82858.17141828625, 83802.58098709528, 86981.0, 88107.55946220292, 10900.672979810619, 10997.34015959045, 11144.721381965515, 11379.886201138048, 11380.089592832554, 15539.766903496457, 15569.377224911103, 15621.0, 15626.453074142577, 15667.2949717263, 7554.773356799305, 7699.499532530368, 7851.803704907309, 7852.528848269122, 7902.0, 7110.7511237106455, 7114.288571142844, 7130.215676275606, 7347.706091756377, 7381.630918454056, 4830.275458681226, 4870.6103511718975, 4899.191633380452, 4918.188498897642, 4981.750912454363, 1999.4401567561106, 2016.9814243806784, 2045.222815330165, 2045.233037610896, 2121.734783152106, 929.5538141692026, 957.9425234485954, 988.0958922585897, 1005.3515482513737, 1062.081299675775, 19739.309124180585, 19769.901150494155, 19793.40619781409, 19927.60144797096, 20011.699824502644, 1004.864343313658, 1008.6570566007592, 1024.3444195714599, 1038.8389799581078, 1046.1160319530138, 10566.947165264124, 11062.170337224741, 11110.000099991039, 11134.221709144811, 11188.272762270426, 515255.0, 516038.0, 516611.0, 519970.0, 521192.0, 87404.5629771847, 88376.558117209, 89805.55097224472, 101562.0, 102917.0, 992.9982171847466, 1014.9086582207636, 1032.3238278927315, 1039.9376037437778, 1045.5608644369383, 15441.691166176839, 16125.75811362807, 17455.214515347096, 18195.45413637593, 18279.725804113215, 42114.789426052674, 42796.0, 43115.7844210777, 45166.0, 45327.32009019933, 60585.0, 60623.0, 61172.94135293306, 62726.37273627205, 63688.0, 8094.352451803724, 8274.213949674771, 8361.540115293474, 8435.15648435176, 8730.607122679368, 9353.953230233805, 11073.889261107608, 11706.180567360203, 11977.760444790882, 12402.81395779082, 10942.288751231144, 10989.890101099207, 10995.890041099487, 11194.720131996439, 11249.887501125211, 10494.632687856194, 10504.264701470824, 10847.186461015297, 10863.511141998788, 10889.727756806144, 10596.15230781551, 10661.840072399076, 10672.733181670521, 10995.615153469591, 11142.442877855912, 7502.249775022454, 8170.264676178935, 8294.129116442688, 8304.958475207586, 8478.74563763088, 9471.337006409762, 10304.845427318447, 10601.840972385575, 10659.467026648792, 10869.184811139354], "value": 9155.08925148876, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.7249558831613, 1496.6108811708955, 1682.3270691723317, 1813.1568820498464, 1820.2536959846466, 8018.158093400197, 8489.872651910218, 8834.823303533942, 9134.543272836365, 9161.725148245556, 8919.732408027754, 8986.550672466383, 9012.143846334604, 9015.459072455656, 9038.18656320931, 2382.761723827616, 2430.647556104364, 2436.074291769134, 2439.951200975979, 2443.035001174535, 2410.4696966667393, 2426.4297889995923, 2427.1262345555588, 2431.2098567965395, 2432.5013372258645, 2382.833201675883, 2403.267003563912, 2431.4529230923076, 2435.3181109289426, 2437.0617312334703, 2383.5828729972272, 2388.235764555343, 2392.940176495584, 2399.616061430163, 2400.84394514356, 2328.5342931413784, 2331.4754180309465, 2347.917822876191, 2348.121502797772, 2361.409647588103, 8828.0, 8841.292696584322, 8852.336074794352, 8884.333674974338, 8885.689000885002, 5370.060239458079, 5467.097928841776, 5511.0, 5517.475839795213, 5538.833834984957, 3420.4185288500767, 3459.031471188046, 3470.8264586770815, 3487.2153765402836, 3533.0460775590705, 1077.4343469678481, 1084.2897901874285, 1102.2504696806168, 1103.7902798468265, 1115.0, 12373.13388062836, 12414.255144691348, 12481.251124932533, 12496.375181240901, 12536.059795515373, 4771.165046116985, 4784.40194975628, 4836.709797412166, 4955.876103097379, 4956.306117143603, 10537.420441875616, 10559.788804223872, 10579.84130238047, 10597.89402105969, 10629.89370106289, 5466.9179962300595, 5489.752961116679, 5530.972345138249, 5535.916961245584, 5535.944640553624, 4390.7585082820115, 4903.950960490421, 5014.222795466709, 5036.143855544567, 5050.4949505049935, 4087.8364865405647, 4099.904144182752, 4164.7709375984, 4177.97911010443, 4182.142660754538, 1267.6894160930447, 1274.8215249865027, 1278.859325474197, 1337.5385492005244, 1344.2203521957242, 891.3493150000536, 1006.104566935428, 1026.7843752811843, 1036.6682661548382, 1041.0890470838017, 6022.608530445507, 6072.180255665517, 6282.654454004982, 6301.7164227608955, 6389.712462939179, 467.96256299495957, 471.23894909720553, 479.87043498255974, 481.0547274605417, 488.655497873998, 4364.738115713068, 4380.69335146543, 4404.9119017620105, 4406.581374769392, 4429.202743506135, 10727.946360268148, 10991.0, 11085.334879907232, 11194.992450679478, 11197.888021119847, 10480.790384192274, 11026.283291586022, 11085.72285692848, 11087.0, 11105.444727763579, 8223.342132629496, 8344.541050242295, 8394.328453723687, 8443.95778021106, 8450.746477605682, 6192.572310797801, 6216.751329946932, 6232.501399887908, 6237.407446292595, 6467.126937863516, 10364.637237696645, 10372.27394082407, 10400.167986560906, 10436.843447348449, 10519.26365154432, 9934.751631209278, 10185.74535636615, 10267.024632659886, 10463.424511651932, 10513.106385957279, 7171.533850299714, 7762.961185194264, 7916.218850758533, 7996.360291176576, 8187.877181842158, 8848.601812918563, 8991.010988791359, 8994.100589940954, 8997.730068097968, 9000.594973226089, 7930.762077137695, 8052.275295223458, 8074.273315401642, 8181.976556083769, 8319.084900660802, 7786.299233069051, 7841.607919604111, 7868.347646993966, 7978.680852765824, 8098.635561399633, 6907.792766217021, 7190.928090719235, 7315.451341149329, 7316.487845850739, 7376.815579610553, 5256.369235691742, 5283.365996080495, 5319.813806516753, 5348.545373643284, 5529.30883639545, 5341.5981942210265, 5485.451454854483, 5551.500364967173, 5588.608797384144, 5591.412901645432], "value": 4696.015042840396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.40765771386657, 343.8590178027009, 346.3775910474716, 351.8733256027831, 353.31985927090363, 5566.693831839248, 5637.915431268534, 5718.199452076713, 5727.312722473303, 5766.82699519014, 5534.920690465361, 5577.944220557793, 5590.133529302964, 5596.832095037145, 5662.773489060443, 3885.49488566486, 4134.855280065199, 4260.637845783112, 4295.484541854982, 4304.849330273441, 4313.7705753860155, 4322.0, 4325.74045557266, 4328.805203765823, 4343.109662519176, 4288.571142885718, 4301.8064187111495, 4311.698181127323, 4320.96296888746, 4339.717918335314, 4250.91498170038, 4269.765162916038, 4277.743335399886, 4335.913281734363, 4336.002719374545, 3764.0, 3769.7738135711943, 3770.4344348347695, 3777.3946072919175, 3800.9737370909697, 5435.211894275308, 5450.400455949843, 5460.453954604547, 5477.698726570037, 5487.149491828773, 4815.0, 4940.802367905279, 4989.7525618595355, 4996.2755400467095, 5015.598752099823, 5740.885182296331, 5769.855753606152, 5771.499410153348, 5773.9422605773825, 5831.271091113611, 4075.2257071156682, 4112.670986321087, 4120.381942708587, 4149.460570125894, 4175.144095460454, 5820.708964551755, 6038.071535305374, 6048.69756512177, 6121.898058349495, 6140.846478838065, 4313.892152696208, 4315.719478233905, 4316.482022157361, 4331.177076355482, 4333.653307735373, 4371.9944412785235, 4377.759223242752, 4379.3649920761945, 4379.912401751947, 4384.210842048462, 4715.929261061086, 4973.850784476472, 5000.948851889182, 5013.423456302572, 5019.945811379651, 5802.912956305659, 5860.912086318709, 5862.384449632812, 5875.23621929155, 5961.135635332939, 1476.158589603937, 1497.7828214908996, 1500.1524138861507, 1500.7973923520403, 1502.4290769507518, 897.582624079806, 950.9476978766235, 951.653410424242, 960.1550635440767, 967.2842096848423, 4841.249606310957, 4882.509919940856, 4890.992039895439, 4920.40955085392, 4926.965337279212, 5271.578273738169, 5300.6024548158275, 5303.549198318109, 5319.707416092075, 5321.36143662763, 4648.5119062498625, 4943.393397145942, 4954.355933728592, 4978.701277923336, 4998.250262460588, 2764.654418197725, 2794.9099851058104, 2797.9020734274204, 2802.8738706758245, 2815.7747380209944, 5409.107497262986, 5428.0, 5429.4299098594865, 5437.8368648940595, 5442.510174084351, 5133.613924240434, 5306.230596563477, 5349.759260833272, 5364.559125597922, 5959.910601340984, 6203.565750397519, 6211.534134939807, 6227.941249987513, 6271.27880293763, 6284.711634114996, 6058.787942421994, 6077.969610151921, 6130.601510901777, 6148.16999705052, 6158.538109641884, 5868.2077919482035, 5967.0, 5976.8804623908145, 5979.671118088547, 6031.0, 6244.063390491463, 6259.78090766821, 6285.308616052139, 6290.465310448663, 6318.462930650946, 4135.338345864648, 4220.0, 4235.534091250021, 4246.278132717383, 4276.187524370484, 5982.012967860254, 5987.88024239504, 5991.940080599138, 6044.607100538451, 6046.818595442144, 5832.795852145155, 5854.795082172103, 5872.941270587239, 5894.115882617642, 5910.290765108214, 5545.279113715191, 5776.191333213437, 5842.444967728059, 5857.560682948711, 5893.5874488785375, 5828.173335932154, 5844.626512769581, 5875.764969401176, 5875.853103672443, 5892.911606325994, 5706.942930570807, 5864.44287792659, 5894.233749612523, 5996.160537524663, 6017.729202185825, 5717.0, 5750.597458177887, 5764.193012978102, 5767.9134812977, 5792.420757924174], "value": 4364.067833825463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.5962909843234, 758.3364556013488, 800.0319613267945, 829.3448175941005, 872.0799556467932, 15558.144302063396, 16757.664846703057, 16790.328386864527, 16792.160391980397, 16795.664086718258, 15141.31864066117, 15353.923230383833, 15365.92317038416, 15403.229838508087, 15404.460843870467, 654.4175683641563, 779.0923574036269, 795.0340336491176, 807.6688557691348, 807.7213361390311, 808.4421748993205, 809.2635701511625, 810.8256724804166, 814.1695470619964, 815.4699445360504, 860.9612567434449, 860.9612567434449, 862.6290695001147, 864.6584599083359, 869.3740506835101, 852.6504133305377, 858.8711693246, 859.3898332184157, 862.1766213266316, 862.3489265604428, 631.2298995225817, 632.1402892066785, 632.7816903168399, 633.8542135308859, 635.044258391123, 13722.931385343109, 13849.792253116211, 13855.584332469942, 13856.030077894551, 13860.861391386057, 15126.470573529874, 15719.764203536955, 16066.036037837766, 16071.758923616155, 16251.349946002145, 12683.74632507354, 12688.566472322049, 12731.61805145838, 12832.80750788739, 12932.35338233094, 3867.3812190049457, 3959.4456776051375, 3969.622885825842, 4029.9194016119804, 4041.090754580225, 82157.0, 85511.57244213739, 85769.0, 86190.0, 86192.56903715504, 11479.655610331703, 11699.0, 11740.589079382351, 11877.762444751057, 11918.046556275478, 23294.184703535295, 23351.532969340857, 23355.416114597272, 23551.646725299135, 23583.882080589487, 8814.118588141135, 8842.646294148291, 8896.46621202717, 8941.329400294873, 9341.439513629204, 4508.18852606534, 4780.402449693788, 4832.275158726219, 4884.145274576935, 4904.2643603459055, 3561.8753343633366, 3643.4534819777246, 3683.355412802802, 3694.242680250542, 3698.3712768829364, 580.3558050563871, 587.823652904127, 590.462678962151, 604.73089475184, 613.8035828534915, 673.4780545077506, 722.5231347310855, 739.0588130537303, 757.0763668324745, 770.1989930472358, 9223.584938677775, 9913.157381622643, 9929.404235745878, 10299.073083422529, 10529.473526323653, 673.3064943108508, 734.3354264390734, 778.5756762564416, 790.3992965346263, 810.5906517208772, 4444.777761111932, 4753.073150735642, 4782.95217047832, 4840.903181936342, 4919.803207871645, 71574.64212679007, 71654.2834571658, 71798.64100679463, 116122.8387716129, 120670.0, 103812.48093759634, 105022.0, 107224.46387768011, 107813.0, 108620.0, 56595.717021415454, 95711.0, 95816.52091739497, 98370.0, 98462.50768746111, 9165.633374665205, 9235.953820230856, 9541.332106752461, 10084.294099413264, 10152.847707284544, 51116.74441627768, 53468.73265633647, 54646.0, 55029.0, 55071.72464137814, 52864.73567632291, 56503.15245271242, 77214.0, 78378.6081069591, 79767.0, 12800.35998200105, 13002.154859934075, 13058.15122017066, 13099.738005240033, 13305.0, 14441.422343106158, 14526.491572794901, 14549.563513094625, 15152.469663561722, 15550.455734049254, 14271.928640356731, 14369.209693466959, 14654.63363415923, 14779.778303325244, 14957.326920288831, 13942.512012079529, 14063.789043164565, 14130.222837744022, 14546.272686365428, 14804.481843135438, 14684.265786710408, 14986.175760333286, 15017.399304027716, 15466.458673946358, 15850.52448426549, 11084.279521831055, 11424.428778560872, 11444.0, 11564.826527601925, 11827.526898923947, 11893.166606390154, 12181.573644922386, 12311.69220769488, 12345.567905123278, 12397.504099836266], "value": 7746.62022545721, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 107.0, 115.0, 113.0, 114.0, 114.0, 114.0, 113.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 120.0, 148.0, 171.0, 125.0, 147.0, 143.0, 120.0, 170.0, 119.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 163.0, 177.0, 164.0, 165.0, 162.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 180.0, 78.0, 76.0, 76.0, 75.0, 179.0, 78.0], "value": 96.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 158.0, 86.0, 85.0, 85.0, 142.0, 84.0, 84.0, 149.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 119.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 98.0, 96.0, 95.0, 96.0, 97.0, 97.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 50.0, 54.0, 54.0, 52.0, 50.0, 50.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 62.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 76.0, 82.0, 76.0, 76.0, 86.0, 81.0, 76.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 122.0, 138.0, 122.0, 128.0, 126.0, 143.0, 126.0, 189.0, 124.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 158.0, 156.0, 161.0, 160.0, 162.0, 157.0, 160.0, 156.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 67.0, 65.0, 63.0, 65.0, 66.0, 64.0, 62.0], "value": 64.4, "unit": "score"}]}]} 21:25:25 INFO - Return code: 0 21:25:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:25:25 ERROR - # TBPL SUCCESS # 21:25:25 INFO - Running post-action listener: _resource_record_post_action 21:25:25 INFO - [mozharness: 2016-08-10 04:25:25.508547Z] Finished run-tests step (success) 21:25:25 INFO - Running post-run listener: _resource_record_post_run 21:25:25 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548012032; Read time: 8; Write time: 442904 21:25:25 INFO - TinderboxPrint: CPU usage
13.3% 21:25:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 21:25:25 INFO - TinderboxPrint: I/O write bytes / time
548,012,032 / 442,904 21:25:25 INFO - TinderboxPrint: CPU idle
8,236.2 (86.7%) 21:25:25 INFO - TinderboxPrint: CPU user
1,210.4 (12.7%) 21:25:25 INFO - TinderboxPrint: Swap in / out
0 / 0 21:25:25 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254943232; Read time: 0; Write time: 259204 21:25:25 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 292646912; Read time: 0; Write time: 183624 21:25:26 INFO - Running post-run listener: _upload_blobber_files 21:25:26 INFO - Blob upload gear active. 21:25:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:25:26 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 21:25:26 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:25:26 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:25:26 INFO - (blobuploader) - INFO - Open directory for files ... 21:25:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:25:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:25:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:25:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:25:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:25:28 INFO - (blobuploader) - INFO - Done attempting. 21:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:25:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:25:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:25:40 INFO - (blobuploader) - INFO - Done attempting. 21:25:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:25:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:25:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:25:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:25:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:25:40 INFO - (blobuploader) - INFO - Done attempting. 21:25:40 INFO - (blobuploader) - INFO - Iteration through files over. 21:25:40 INFO - Return code: 0 21:25:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:25:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:25:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/76221d592baec4d1cf5c6a5c70e7f790ac5d61ccae4a727787b85b3abe75617de8d48da7dd58061701c33ebfd5efed8c6528058185e8fd0b5255dc13aa1e301d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e24d5408ac4851593b6acd337960ba31d2e44e5cace7f78edef12dd2489b10ed0435506cc4136e5c2528424f349bbe035340494a18f640fe8ff6af4355a689bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e7c26da43d541fa0f56f8766b261e4be1b8de5db76121c89839df4dc12f8216e9034e274e14890498afe9980306025e4598931a0c7191c73fb88280547d8895"} 21:25:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:25:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:25:40 INFO - Contents: 21:25:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/76221d592baec4d1cf5c6a5c70e7f790ac5d61ccae4a727787b85b3abe75617de8d48da7dd58061701c33ebfd5efed8c6528058185e8fd0b5255dc13aa1e301d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e24d5408ac4851593b6acd337960ba31d2e44e5cace7f78edef12dd2489b10ed0435506cc4136e5c2528424f349bbe035340494a18f640fe8ff6af4355a689bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e7c26da43d541fa0f56f8766b261e4be1b8de5db76121c89839df4dc12f8216e9034e274e14890498afe9980306025e4598931a0c7191c73fb88280547d8895"} 21:25:40 INFO - Running post-run listener: copy_logs_to_upload_dir 21:25:40 INFO - Copying logs to upload dir... 21:25:40 INFO - mkdir: /builds/slave/test/build/upload/logs 21:25:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.730755 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-09 21:25:40.040452) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 21:25:40.043874) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584 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/sha512/76221d592baec4d1cf5c6a5c70e7f790ac5d61ccae4a727787b85b3abe75617de8d48da7dd58061701c33ebfd5efed8c6528058185e8fd0b5255dc13aa1e301d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e24d5408ac4851593b6acd337960ba31d2e44e5cace7f78edef12dd2489b10ed0435506cc4136e5c2528424f349bbe035340494a18f640fe8ff6af4355a689bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e7c26da43d541fa0f56f8766b261e4be1b8de5db76121c89839df4dc12f8216e9034e274e14890498afe9980306025e4598931a0c7191c73fb88280547d8895"} build_url:https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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/sha512/76221d592baec4d1cf5c6a5c70e7f790ac5d61ccae4a727787b85b3abe75617de8d48da7dd58061701c33ebfd5efed8c6528058185e8fd0b5255dc13aa1e301d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e24d5408ac4851593b6acd337960ba31d2e44e5cace7f78edef12dd2489b10ed0435506cc4136e5c2528424f349bbe035340494a18f640fe8ff6af4355a689bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e7c26da43d541fa0f56f8766b261e4be1b8de5db76121c89839df4dc12f8216e9034e274e14890498afe9980306025e4598931a0c7191c73fb88280547d8895"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 21:25:40.073116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:25:40.073522) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1470789350.819514-1656437584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:25:40.157533) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 21:25:40.157889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 21:25:40.158231) ========= ========= Total master_lag: 0.17 =========