builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1467946758.05 results: success (0) buildid: 20160707183001 builduid: 36912eddb439489281feac71fdad589d revision: be469964755162110602a8690cc9e7034fd3981b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.051734) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.052229) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.052573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.069298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.069703) ========= 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=32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 19:59:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-07 19:59:18 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.174034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.174369) ========= 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=32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014370 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.227749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.228570) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev be469964755162110602a8690cc9e7034fd3981b --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 be469964755162110602a8690cc9e7034fd3981b --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=32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 19:59:18,965 truncating revision to first 12 chars 2016-07-07 19:59:18,965 Setting DEBUG logging. 2016-07-07 19:59:18,965 attempt 1/10 2016-07-07 19:59:18,965 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/be4699647551?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 19:59:19,299 unpacking tar archive at: autoland-be4699647551/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661808 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.906027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.906394) ========= script_repo_revision: be469964755162110602a8690cc9e7034fd3981b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.906817) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.907128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 19:59:18.917876) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-07 19:59:18.918218) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:59:19 INFO - MultiFileLogger online at 20160707 19:59:19 in /builds/slave/test 19:59:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 19:59:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:59:19 INFO - {'append_to_log': False, 19:59:19 INFO - 'base_work_dir': '/builds/slave/test', 19:59:19 INFO - 'blob_upload_branch': 'Autoland', 19:59:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:59:19 INFO - 'branch': 'Autoland', 19:59:19 INFO - 'buildbot_json_path': 'buildprops.json', 19:59:19 INFO - 'config_files': ('talos/linux_config.py',), 19:59:19 INFO - 'default_actions': ('clobber', 19:59:19 INFO - 'read-buildbot-config', 19:59:19 INFO - 'download-and-extract', 19:59:19 INFO - 'populate-webroot', 19:59:19 INFO - 'create-virtualenv', 19:59:19 INFO - 'install', 19:59:19 INFO - 'run-tests'), 19:59:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:59:19 INFO - 'download_minidump_stackwalk': True, 19:59:19 INFO - 'download_symbols': 'ondemand', 19:59:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:59:19 INFO - 'tooltool.py': '/tools/tooltool.py', 19:59:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:59:19 INFO - '/tools/misc-python/virtualenv.py')}, 19:59:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:59:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:59:19 INFO - 'installer_path': 'installer.exe', 19:59:19 INFO - 'log_level': 'info', 19:59:19 INFO - 'log_name': 'talos', 19:59:19 INFO - 'log_to_console': True, 19:59:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:59:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:59:19 INFO - 'opt_config_files': (), 19:59:19 INFO - 'pip_index': False, 19:59:19 INFO - 'sps_profile': False, 19:59:19 INFO - 'sps_profile_interval': 0, 19:59:19 INFO - 'suite': 'dromaeojs', 19:59:19 INFO - 'system_bits': '32', 19:59:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:59:19 INFO - 'title': 'talos-linux64-ix-008', 19:59:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:59:19 INFO - 'use_talos_json': True, 19:59:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:59:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:59:19 INFO - 'work_dir': 'build'} 19:59:19 INFO - ##### 19:59:19 INFO - ##### Running clobber step. 19:59:19 INFO - ##### 19:59:19 INFO - Running pre-action listener: _resource_record_pre_action 19:59:19 INFO - Running main action method: clobber 19:59:19 INFO - rmtree: /builds/slave/test/build 19:59:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:59:20 INFO - Running post-action listener: _resource_record_post_action 19:59:20 INFO - ##### 19:59:20 INFO - ##### Finished clobber step (success) 19:59:20 INFO - ##### 19:59:20 INFO - ##### 19:59:20 INFO - ##### Running read-buildbot-config step. 19:59:20 INFO - ##### 19:59:20 INFO - Running pre-action listener: _resource_record_pre_action 19:59:20 INFO - Running main action method: read_buildbot_config 19:59:20 INFO - Using buildbot properties: 19:59:20 INFO - { 19:59:20 INFO - "project": "", 19:59:20 INFO - "product": "firefox", 19:59:20 INFO - "script_repo_revision": "production", 19:59:20 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 19:59:20 INFO - "repository": "", 19:59:20 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 19:59:20 INFO - "buildid": "20160707183001", 19:59:20 INFO - "pgo_build": "True", 19:59:20 INFO - "basedir": "/builds/slave/test", 19:59:20 INFO - "buildnumber": 20, 19:59:20 INFO - "slavename": "talos-linux64-ix-008", 19:59:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:59:20 INFO - "platform": "ubuntu64_hw", 19:59:20 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 19:59:20 INFO - "branch": "autoland", 19:59:20 INFO - "repo_path": "integration/autoland", 19:59:20 INFO - "revision": "be469964755162110602a8690cc9e7034fd3981b", 19:59:20 INFO - "stage_platform": "linux64-pgo", 19:59:20 INFO - "builduid": "36912eddb439489281feac71fdad589d", 19:59:20 INFO - "slavebuilddir": "test" 19:59:20 INFO - } 19:59:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:59:20 INFO - Running post-action listener: _resource_record_post_action 19:59:20 INFO - ##### 19:59:20 INFO - ##### Finished read-buildbot-config step (success) 19:59:20 INFO - ##### 19:59:20 INFO - ##### 19:59:20 INFO - ##### Running download-and-extract step. 19:59:20 INFO - ##### 19:59:20 INFO - Running pre-action listener: _resource_record_pre_action 19:59:20 INFO - Running main action method: download_and_extract 19:59:20 INFO - mkdir: /builds/slave/test/build/tests 19:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:20 INFO - https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:59:26 INFO - Downloaded 1361 bytes. 19:59:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:59:26 INFO - Using the following test package requirements: 19:59:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:59:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:59:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:26 INFO - u'jsshell-linux-x86_64.zip'], 19:59:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:59:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:59:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:59:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:59:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:59:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:26 INFO - https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:59:29 INFO - Downloaded 24304293 bytes. 19:59:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:59:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:59:31 INFO - Return code: 0 19:59:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:31 INFO - https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:59:33 INFO - Downloaded 24304293 bytes. 19:59:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:59:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:59:35 INFO - Return code: 0 19:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:35 INFO - https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:59:36 INFO - Downloaded 14403333 bytes. 19:59:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:59:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:59:36 INFO - Return code: 0 19:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:36 INFO - https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:59:38 INFO - Downloaded 60463415 bytes. 19:59:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:59:38 INFO - mkdir: /builds/slave/test/properties 19:59:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:59:38 INFO - Writing to file /builds/slave/test/properties/build_url 19:59:38 INFO - Contents: 19:59:38 INFO - build_url:https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:59:38 INFO - Running post-action listener: _resource_record_post_action 19:59:38 INFO - Running post-action listener: set_extra_try_arguments 19:59:38 INFO - ##### 19:59:38 INFO - ##### Finished download-and-extract step (success) 19:59:38 INFO - ##### 19:59:38 INFO - ##### 19:59:38 INFO - ##### Running populate-webroot step. 19:59:38 INFO - ##### 19:59:38 INFO - Running pre-action listener: _resource_record_pre_action 19:59:38 INFO - Running main action method: populate_webroot 19:59:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:38 INFO - '--tppagecycles', 19:59:38 INFO - '7'], 19:59:38 INFO - 'tests': ['tsvgm']}}, 19:59:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:59:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:59:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:59:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:38 INFO - 'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:38 INFO - 'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['damp', 'tps']}, 19:59:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:38 INFO - 'tests': ['damp', 'tps']}, 19:59:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['dromaeo_dom']}, 19:59:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['basic_compositor_video']}, 19:59:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:59:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['a11yr', 19:59:38 INFO - 'ts_paint', 19:59:38 INFO - 'tpaint', 19:59:38 INFO - 'sessionrestore', 19:59:38 INFO - 'sessionrestore_no_auto_restore', 19:59:38 INFO - 'tabpaint']}, 19:59:38 INFO - 'other-e10s': {'tests': ['a11yr', 19:59:38 INFO - 'ts_paint', 19:59:38 INFO - 'tpaint', 19:59:38 INFO - 'sessionrestore', 19:59:38 INFO - 'sessionrestore_no_auto_restore', 19:59:38 INFO - 'tabpaint']}, 19:59:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:59:38 INFO - 'ts_paint', 19:59:38 INFO - 'tpaint', 19:59:38 INFO - 'sessionrestore', 19:59:38 INFO - 'sessionrestore_no_auto_restore', 19:59:38 INFO - 'tabpaint']}, 19:59:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:59:38 INFO - 'ts_paint', 19:59:38 INFO - 'tpaint', 19:59:38 INFO - 'sessionrestore', 19:59:38 INFO - 'sessionrestore_no_auto_restore', 19:59:38 INFO - 'tabpaint']}, 19:59:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['a11yr', 19:59:38 INFO - 'ts_paint', 19:59:38 INFO - 'tpaint', 19:59:38 INFO - 'sessionrestore', 19:59:38 INFO - 'sessionrestore_no_auto_restore', 19:59:38 INFO - 'tabpaint']}, 19:59:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['a11yr', 19:59:38 INFO - 'ts_paint', 19:59:38 INFO - 'tpaint', 19:59:38 INFO - 'sessionrestore', 19:59:38 INFO - 'sessionrestore_no_auto_restore', 19:59:38 INFO - 'tabpaint']}, 19:59:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['tsvgx', 19:59:38 INFO - 'tsvgr_opacity', 19:59:38 INFO - 'tart', 19:59:38 INFO - 'tscrollx', 19:59:38 INFO - 'cart']}, 19:59:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:59:38 INFO - 'tsvgr_opacity', 19:59:38 INFO - 'tart', 19:59:38 INFO - 'tscrollx', 19:59:38 INFO - 'cart']}, 19:59:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:38 INFO - 'talos_options': ['--disable-e10s'], 19:59:38 INFO - 'tests': ['tp5o']}, 19:59:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:38 INFO - 'tests': ['tp5o']}, 19:59:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:38 INFO - 'talos_options': ['--disable-e10s', 19:59:38 INFO - '--xperf_path', 19:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:38 INFO - 'tests': ['tp5n']}, 19:59:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:38 INFO - 'talos_options': ['--xperf_path', 19:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:38 INFO - 'tests': ['tp5n']}}, 19:59:38 INFO - 'talos.zip': {'path': '', 19:59:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:38 INFO - Running post-action listener: _resource_record_post_action 19:59:38 INFO - ##### 19:59:38 INFO - ##### Finished populate-webroot step (success) 19:59:38 INFO - ##### 19:59:38 INFO - ##### 19:59:38 INFO - ##### Running create-virtualenv step. 19:59:38 INFO - ##### 19:59:38 INFO - Running pre-action listener: _resource_record_pre_action 19:59:38 INFO - Running main action method: create_virtualenv 19:59:38 INFO - Creating virtualenv /builds/slave/test/build/venv 19:59:38 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 19:59:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:59:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:39 INFO - Using real prefix '/usr' 19:59:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:59:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:41 INFO - Installing pip.................done. 19:59:41 INFO - Return code: 0 19:59:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d3b0>, '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 0x126e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e740>, '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': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', '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 19:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:59:41 INFO - Using env: {'DISPLAY': ':0', 19:59:41 INFO - 'HOME': '/home/cltbld', 19:59:41 INFO - 'LANG': 'en_US.UTF-8', 19:59:41 INFO - 'LANGUAGE': 'en_US:en', 19:59:41 INFO - 'LOGNAME': 'cltbld', 19:59:41 INFO - 'MAIL': '/var/mail/cltbld', 19:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:41 INFO - 'MOZ_NO_REMOTE': '1', 19:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:41 INFO - 'NO_EM_RESTART': '1', 19:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:41 INFO - 'PWD': '/builds/slave/test', 19:59:41 INFO - 'SHELL': '/bin/bash', 19:59:41 INFO - 'SHLVL': '1', 19:59:41 INFO - 'TERM': 'linux', 19:59:41 INFO - 'TMOUT': '86400', 19:59:41 INFO - 'USER': 'cltbld', 19:59:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', 19:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:41 INFO - '_': '/tools/buildbot/bin/python'} 19:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:41 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 19:59:41 INFO - Cleaning up... 19:59:41 INFO - Return code: 0 19:59:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d3b0>, '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 0x126e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e740>, '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': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', '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 19:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:59:41 INFO - Using env: {'DISPLAY': ':0', 19:59:41 INFO - 'HOME': '/home/cltbld', 19:59:41 INFO - 'LANG': 'en_US.UTF-8', 19:59:41 INFO - 'LANGUAGE': 'en_US:en', 19:59:41 INFO - 'LOGNAME': 'cltbld', 19:59:41 INFO - 'MAIL': '/var/mail/cltbld', 19:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:41 INFO - 'MOZ_NO_REMOTE': '1', 19:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:41 INFO - 'NO_EM_RESTART': '1', 19:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:41 INFO - 'PWD': '/builds/slave/test', 19:59:41 INFO - 'SHELL': '/bin/bash', 19:59:41 INFO - 'SHLVL': '1', 19:59:41 INFO - 'TERM': 'linux', 19:59:41 INFO - 'TMOUT': '86400', 19:59:41 INFO - 'USER': 'cltbld', 19:59:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', 19:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:41 INFO - '_': '/tools/buildbot/bin/python'} 19:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:42 INFO - Downloading/unpacking psutil>=3.1.1 19:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:44 INFO - Installing collected packages: psutil 19:59:44 INFO - Running setup.py install for psutil 19:59:44 INFO - building 'psutil._psutil_linux' extension 19:59:44 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 19:59:44 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 19:59:44 INFO - building 'psutil._psutil_posix' extension 19:59:44 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 19:59:44 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 19:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:44 INFO - Successfully installed psutil 19:59:44 INFO - Cleaning up... 19:59:44 INFO - Return code: 0 19:59:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:44 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 0xfae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d3b0>, '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 0x126e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e740>, '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': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', '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 19:59:44 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 19:59:44 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 19:59:44 INFO - Using env: {'DISPLAY': ':0', 19:59:44 INFO - 'HOME': '/home/cltbld', 19:59:44 INFO - 'LANG': 'en_US.UTF-8', 19:59:44 INFO - 'LANGUAGE': 'en_US:en', 19:59:44 INFO - 'LOGNAME': 'cltbld', 19:59:44 INFO - 'MAIL': '/var/mail/cltbld', 19:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:44 INFO - 'MOZ_NO_REMOTE': '1', 19:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:44 INFO - 'NO_EM_RESTART': '1', 19:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:44 INFO - 'PWD': '/builds/slave/test', 19:59:44 INFO - 'SHELL': '/bin/bash', 19:59:44 INFO - 'SHLVL': '1', 19:59:44 INFO - 'TERM': 'linux', 19:59:44 INFO - 'TMOUT': '86400', 19:59:44 INFO - 'USER': 'cltbld', 19:59:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', 19:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:44 INFO - '_': '/tools/buildbot/bin/python'} 19:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:59:44 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 19:59:44 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 19:59:44 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 19:59:44 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 19:59:44 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 19:59:44 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 19:59:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:59:46 INFO - Installing collected packages: mozsystemmonitor 19:59:46 INFO - Running setup.py install for mozsystemmonitor 19:59:46 INFO - Successfully installed mozsystemmonitor 19:59:46 INFO - Cleaning up... 19:59:46 INFO - Return code: 0 19:59:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d3b0>, '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 0x126e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e740>, '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': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', '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 19:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:59:46 INFO - Using env: {'DISPLAY': ':0', 19:59:46 INFO - 'HOME': '/home/cltbld', 19:59:46 INFO - 'LANG': 'en_US.UTF-8', 19:59:46 INFO - 'LANGUAGE': 'en_US:en', 19:59:46 INFO - 'LOGNAME': 'cltbld', 19:59:46 INFO - 'MAIL': '/var/mail/cltbld', 19:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:46 INFO - 'MOZ_NO_REMOTE': '1', 19:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:46 INFO - 'NO_EM_RESTART': '1', 19:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:46 INFO - 'PWD': '/builds/slave/test', 19:59:46 INFO - 'SHELL': '/bin/bash', 19:59:46 INFO - 'SHLVL': '1', 19:59:46 INFO - 'TERM': 'linux', 19:59:46 INFO - 'TMOUT': '86400', 19:59:46 INFO - 'USER': 'cltbld', 19:59:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', 19:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:46 INFO - '_': '/tools/buildbot/bin/python'} 19:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:47 INFO - Downloading/unpacking jsonschema==2.5.1 19:59:47 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 19:59:47 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 19:59:47 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 19:59:47 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 19:59:47 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 19:59:47 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 19:59:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:49 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:49 INFO - warning: no files found matching '*.txt' 19:59:49 INFO - no previously-included directories found matching 'build' 19:59:49 INFO - no previously-included directories found matching 'dist' 19:59:49 INFO - no previously-included directories found matching '.git*' 19:59:49 INFO - Installing collected packages: jsonschema, functools32 19:59:49 INFO - Running setup.py install for functools32 19:59:49 INFO - warning: no files found matching '*.txt' 19:59:49 INFO - no previously-included directories found matching 'build' 19:59:49 INFO - no previously-included directories found matching 'dist' 19:59:49 INFO - no previously-included directories found matching '.git*' 19:59:49 INFO - Successfully installed jsonschema functools32 19:59:49 INFO - Cleaning up... 19:59:49 INFO - Return code: 0 19:59:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:49 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 0xfae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d3b0>, '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 0x126e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e740>, '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': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', '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 19:59:49 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 19:59:49 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 19:59:49 INFO - Using env: {'DISPLAY': ':0', 19:59:49 INFO - 'HOME': '/home/cltbld', 19:59:49 INFO - 'LANG': 'en_US.UTF-8', 19:59:49 INFO - 'LANGUAGE': 'en_US:en', 19:59:49 INFO - 'LOGNAME': 'cltbld', 19:59:49 INFO - 'MAIL': '/var/mail/cltbld', 19:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:49 INFO - 'MOZ_NO_REMOTE': '1', 19:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:49 INFO - 'NO_EM_RESTART': '1', 19:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:49 INFO - 'PWD': '/builds/slave/test', 19:59:49 INFO - 'SHELL': '/bin/bash', 19:59:49 INFO - 'SHLVL': '1', 19:59:49 INFO - 'TERM': 'linux', 19:59:49 INFO - 'TMOUT': '86400', 19:59:49 INFO - 'USER': 'cltbld', 19:59:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', 19:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:49 INFO - '_': '/tools/buildbot/bin/python'} 19:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:49 INFO - Downloading/unpacking blobuploader==1.2.4 19:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:59:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59:52 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 19:59:52 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 19:59:52 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 19:59:52 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 19:59:52 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 19:59:52 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 19:59:52 INFO - Downloading docopt-0.6.1.tar.gz 19:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:52 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:52 INFO - Running setup.py install for blobuploader 19:59:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:59:52 INFO - Running setup.py install for requests 19:59:52 INFO - Running setup.py install for docopt 19:59:52 INFO - Successfully installed blobuploader requests docopt 19:59:52 INFO - Cleaning up... 19:59:53 INFO - Return code: 0 19:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:53 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 0xfae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d3b0>, '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 0x126e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e740>, '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': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', '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 19:59:53 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 19:59:53 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 19:59:53 INFO - Using env: {'DISPLAY': ':0', 19:59:53 INFO - 'HOME': '/home/cltbld', 19:59:53 INFO - 'LANG': 'en_US.UTF-8', 19:59:53 INFO - 'LANGUAGE': 'en_US:en', 19:59:53 INFO - 'LOGNAME': 'cltbld', 19:59:53 INFO - 'MAIL': '/var/mail/cltbld', 19:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:53 INFO - 'MOZ_NO_REMOTE': '1', 19:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:53 INFO - 'NO_EM_RESTART': '1', 19:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:53 INFO - 'PWD': '/builds/slave/test', 19:59:53 INFO - 'SHELL': '/bin/bash', 19:59:53 INFO - 'SHLVL': '1', 19:59:53 INFO - 'TERM': 'linux', 19:59:53 INFO - 'TMOUT': '86400', 19:59:53 INFO - 'USER': 'cltbld', 19:59:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', 19:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:53 INFO - '_': '/tools/buildbot/bin/python'} 19:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:53 INFO - Running setup.py (path:/tmp/pip-GwJCxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:53 INFO - Running setup.py (path:/tmp/pip-nfR0My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:53 INFO - Running setup.py (path:/tmp/pip-yCDPWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:53 INFO - Running setup.py (path:/tmp/pip-uZPGXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:53 INFO - Running setup.py (path:/tmp/pip-GSHmiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:53 INFO - Running setup.py (path:/tmp/pip-QnPC8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:53 INFO - Running setup.py (path:/tmp/pip-LTuK7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:53 INFO - Running setup.py (path:/tmp/pip-fVM_1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:53 INFO - Running setup.py (path:/tmp/pip-LWu1RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:53 INFO - Running setup.py (path:/tmp/pip-eBdTgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:53 INFO - Running setup.py (path:/tmp/pip-R6XZxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:54 INFO - Running setup.py (path:/tmp/pip-qHQ82F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:54 INFO - Running setup.py (path:/tmp/pip-pcmJCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:54 INFO - Running setup.py (path:/tmp/pip-uuh0dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:54 INFO - Running setup.py (path:/tmp/pip-Y13EE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:54 INFO - Running setup.py (path:/tmp/pip-UBEhs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:59:54 INFO - Running setup.py (path:/tmp/pip-JeyAfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:59:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:54 INFO - Running setup.py install for manifestparser 19:59:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:59:54 INFO - Running setup.py install for mozcrash 19:59:54 INFO - Running setup.py install for mozdebug 19:59:54 INFO - Running setup.py install for mozdevice 19:59:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:59:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:59:54 INFO - Running setup.py install for mozfile 19:59:54 INFO - Running setup.py install for mozhttpd 19:59:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Running setup.py install for mozinfo 19:59:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Running setup.py install for mozInstall 19:59:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Running setup.py install for mozleak 19:59:55 INFO - Running setup.py install for mozlog 19:59:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Running setup.py install for moznetwork 19:59:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Running setup.py install for mozprocess 19:59:55 INFO - Running setup.py install for mozprofile 19:59:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Running setup.py install for mozrunner 19:59:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:59:55 INFO - Running setup.py install for mozscreenshot 19:59:56 INFO - Running setup.py install for moztest 19:59:56 INFO - Running setup.py install for mozversion 19:59:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:59:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:56 INFO - Cleaning up... 19:59:56 INFO - Return code: 0 19:59:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:56 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 0xfae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d3b0>, '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 0x126e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e740>, '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': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', '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 19:59:56 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 19:59:56 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 19:59:56 INFO - Using env: {'DISPLAY': ':0', 19:59:56 INFO - 'HOME': '/home/cltbld', 19:59:56 INFO - 'LANG': 'en_US.UTF-8', 19:59:56 INFO - 'LANGUAGE': 'en_US:en', 19:59:56 INFO - 'LOGNAME': 'cltbld', 19:59:56 INFO - 'MAIL': '/var/mail/cltbld', 19:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:56 INFO - 'MOZ_NO_REMOTE': '1', 19:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:56 INFO - 'NO_EM_RESTART': '1', 19:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:56 INFO - 'PWD': '/builds/slave/test', 19:59:56 INFO - 'SHELL': '/bin/bash', 19:59:56 INFO - 'SHLVL': '1', 19:59:56 INFO - 'TERM': 'linux', 19:59:56 INFO - 'TMOUT': '86400', 19:59:56 INFO - 'USER': 'cltbld', 19:59:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', 19:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:56 INFO - '_': '/tools/buildbot/bin/python'} 19:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:56 INFO - Running setup.py (path:/tmp/pip-kkfPCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:56 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)) 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:56 INFO - Running setup.py (path:/tmp/pip-mm8J9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:56 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)) 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:56 INFO - Running setup.py (path:/tmp/pip-FdnIFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:56 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)) 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:56 INFO - Running setup.py (path:/tmp/pip-xXGNh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:56 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)) 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:56 INFO - Running setup.py (path:/tmp/pip-WIS2Jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:56 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)) 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:56 INFO - Running setup.py (path:/tmp/pip-8DHWL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:56 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)) 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:56 INFO - Running setup.py (path:/tmp/pip-iIB7Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:56 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)) 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:56 INFO - Running setup.py (path:/tmp/pip-BSro8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:57 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)) 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:57 INFO - Running setup.py (path:/tmp/pip-mO3x1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:57 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)) 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:57 INFO - Running setup.py (path:/tmp/pip-CWrtlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:57 INFO - Running setup.py (path:/tmp/pip-u9X9l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:57 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)) 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:57 INFO - Running setup.py (path:/tmp/pip-8DCOO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:57 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)) 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:57 INFO - Running setup.py (path:/tmp/pip-xnFqa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:57 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)) 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:57 INFO - Running setup.py (path:/tmp/pip-I4slSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:57 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)) 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:57 INFO - Running setup.py (path:/tmp/pip-MIKfJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:57 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)) 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:57 INFO - Running setup.py (path:/tmp/pip-oH1MYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:59:57 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)) 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:59:57 INFO - Running setup.py (path:/tmp/pip-LbvlJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:59:57 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)) 19:59:57 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)) 19:59:57 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)) 19:59:57 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)) 19:59:57 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)) 19:59:57 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)) 19:59:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:59 INFO - Downloading blessings-1.6.tar.gz 19:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:59:59 INFO - Installing collected packages: blessings 19:59:59 INFO - Running setup.py install for blessings 19:59:59 INFO - Successfully installed blessings 19:59:59 INFO - Cleaning up... 19:59:59 INFO - Return code: 0 19:59:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:00 INFO - Reading from file tmpfile_stdout 20:00:00 INFO - Current package versions: 20:00:00 INFO - argparse == 1.2.1 20:00:00 INFO - blessings == 1.6 20:00:00 INFO - blobuploader == 1.2.4 20:00:00 INFO - docopt == 0.6.1 20:00:00 INFO - functools32 == 3.2.3-2 20:00:00 INFO - jsonschema == 2.5.1 20:00:00 INFO - manifestparser == 1.1 20:00:00 INFO - mozInstall == 1.12 20:00:00 INFO - mozcrash == 0.17 20:00:00 INFO - mozdebug == 0.1 20:00:00 INFO - mozdevice == 0.48 20:00:00 INFO - mozfile == 1.2 20:00:00 INFO - mozhttpd == 0.7 20:00:00 INFO - mozinfo == 0.9 20:00:00 INFO - mozleak == 0.1 20:00:00 INFO - mozlog == 3.2 20:00:00 INFO - moznetwork == 0.27 20:00:00 INFO - mozprocess == 0.23 20:00:00 INFO - mozprofile == 0.28 20:00:00 INFO - mozrunner == 6.12 20:00:00 INFO - mozscreenshot == 0.1 20:00:00 INFO - mozsystemmonitor == 0.3 20:00:00 INFO - moztest == 0.7 20:00:00 INFO - mozversion == 1.4 20:00:00 INFO - psutil == 3.1.1 20:00:00 INFO - requests == 1.2.3 20:00:00 INFO - wsgiref == 0.1.2 20:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:00 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 0xfae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d3b0>, '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 0x126e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e740>, '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': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', '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 20:00:00 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 20:00:00 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 20:00:00 INFO - Using env: {'DISPLAY': ':0', 20:00:00 INFO - 'HOME': '/home/cltbld', 20:00:00 INFO - 'LANG': 'en_US.UTF-8', 20:00:00 INFO - 'LANGUAGE': 'en_US:en', 20:00:00 INFO - 'LOGNAME': 'cltbld', 20:00:00 INFO - 'MAIL': '/var/mail/cltbld', 20:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:00 INFO - 'MOZ_NO_REMOTE': '1', 20:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:00 INFO - 'NO_EM_RESTART': '1', 20:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:00 INFO - 'PWD': '/builds/slave/test', 20:00:00 INFO - 'SHELL': '/bin/bash', 20:00:00 INFO - 'SHLVL': '1', 20:00:00 INFO - 'TERM': 'linux', 20:00:00 INFO - 'TMOUT': '86400', 20:00:00 INFO - 'USER': 'cltbld', 20:00:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', 20:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:00 INFO - '_': '/tools/buildbot/bin/python'} 20:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 INFO - Cleaning up... 20:00:00 INFO - Return code: 0 20:00:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d3b0>, '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 0x126e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e740>, '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': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', '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 20:00:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:00:00 INFO - Using env: {'DISPLAY': ':0', 20:00:00 INFO - 'HOME': '/home/cltbld', 20:00:00 INFO - 'LANG': 'en_US.UTF-8', 20:00:00 INFO - 'LANGUAGE': 'en_US:en', 20:00:00 INFO - 'LOGNAME': 'cltbld', 20:00:00 INFO - 'MAIL': '/var/mail/cltbld', 20:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:00 INFO - 'MOZ_NO_REMOTE': '1', 20:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:00 INFO - 'NO_EM_RESTART': '1', 20:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:00 INFO - 'PWD': '/builds/slave/test', 20:00:00 INFO - 'SHELL': '/bin/bash', 20:00:00 INFO - 'SHLVL': '1', 20:00:00 INFO - 'TERM': 'linux', 20:00:00 INFO - 'TMOUT': '86400', 20:00:00 INFO - 'USER': 'cltbld', 20:00:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', 20:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:00 INFO - '_': '/tools/buildbot/bin/python'} 20:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:00:00 INFO - Cleaning up... 20:00:00 INFO - Return code: 0 20:00:00 INFO - Running post-action listener: _resource_record_post_action 20:00:00 INFO - Running post-action listener: _start_resource_monitoring 20:00:00 INFO - Starting resource monitoring. 20:00:00 INFO - ##### 20:00:00 INFO - ##### Finished create-virtualenv step (success) 20:00:00 INFO - ##### 20:00:00 INFO - ##### 20:00:00 INFO - ##### Running install step. 20:00:00 INFO - ##### 20:00:00 INFO - Running pre-action listener: _resource_record_pre_action 20:00:00 INFO - Running main action method: install 20:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:00 INFO - Reading from file tmpfile_stdout 20:00:00 INFO - Detecting whether we're running mozinstall >=1.0... 20:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:00:00 INFO - Reading from file tmpfile_stdout 20:00:00 INFO - Output received: 20:00:00 INFO - Usage: mozinstall [options] installer 20:00:00 INFO - Options: 20:00:00 INFO - -h, --help show this help message and exit 20:00:00 INFO - -d DEST, --destination=DEST 20:00:00 INFO - Directory to install application into. [default: 20:00:00 INFO - "/builds/slave/test"] 20:00:00 INFO - --app=APP Application being installed. [default: firefox] 20:00:00 INFO - mkdir: /builds/slave/test/build/application 20:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:00:18 INFO - Reading from file tmpfile_stdout 20:00:18 INFO - Output received: 20:00:18 INFO - /builds/slave/test/build/application/firefox/firefox 20:00:18 INFO - Running post-action listener: _resource_record_post_action 20:00:18 INFO - ##### 20:00:18 INFO - ##### Finished install step (success) 20:00:18 INFO - ##### 20:00:18 INFO - ##### 20:00:18 INFO - ##### Running run-tests step. 20:00:18 INFO - ##### 20:00:18 INFO - Running pre-action listener: _resource_record_pre_action 20:00:18 INFO - Running main action method: run_tests 20:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:00:18 INFO - Python 2.7.3 20:00:18 INFO - Return code: 0 20:00:18 INFO - grabbing minidump binary from tooltool 20:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:18 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 0x126d3b0>, '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 0x126e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:00:18 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 20:00:18 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 20:00:18 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 20:00:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:00:18 INFO - Return code: 0 20:00:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:00:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:00:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:00:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:00:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:00:18 INFO - Using env: {'DISPLAY': ':0', 20:00:18 INFO - 'HOME': '/home/cltbld', 20:00:18 INFO - 'LANG': 'en_US.UTF-8', 20:00:18 INFO - 'LANGUAGE': 'en_US:en', 20:00:18 INFO - 'LOGNAME': 'cltbld', 20:00:18 INFO - 'MAIL': '/var/mail/cltbld', 20:00:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:00:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:18 INFO - 'MOZ_NO_REMOTE': '1', 20:00:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:18 INFO - 'NO_EM_RESTART': '1', 20:00:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:18 INFO - 'PWD': '/builds/slave/test', 20:00:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:00:18 INFO - 'SHELL': '/bin/bash', 20:00:18 INFO - 'SHLVL': '1', 20:00:18 INFO - 'TERM': 'linux', 20:00:18 INFO - 'TMOUT': '86400', 20:00:18 INFO - 'USER': 'cltbld', 20:00:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938', 20:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:18 INFO - '_': '/tools/buildbot/bin/python'} 20:00:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:00:18 INFO - mozversion application_buildid: 20160707183001 20:00:18 INFO - mozversion application_changeset: be469964755162110602a8690cc9e7034fd3981b 20:00:18 INFO - mozversion application_display_name: Nightly 20:00:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:00:18 INFO - mozversion application_name: Firefox 20:00:18 INFO - mozversion application_remotingname: firefox 20:00:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:00:18 INFO - mozversion application_vendor: Mozilla 20:00:18 INFO - mozversion application_version: 50.0a1 20:00:18 INFO - mozversion platform_buildid: 20160707183001 20:00:18 INFO - mozversion platform_changeset: be469964755162110602a8690cc9e7034fd3981b 20:00:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:00:18 INFO - mozversion platform_version: 50.0a1 20:00:18 INFO - using testdate: 1467946818 20:00:18 INFO - actual date: 1467946818 20:00:18 INFO - starting webserver on 'localhost:37903' 20:00:18 INFO - SUITE-START | Running 2 tests 20:00:18 INFO - TEST-START | dromaeo_css 20:00:18 INFO - operating with platform_type : linux_ 20:00:18 INFO - Initialising browser for dromaeo_css test... 20:00:18 INFO - TEST-INFO | started process 24318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYk9Oji/profile http://localhost:37903/getInfo.html) 20:00:22 INFO - PROCESS | 24318 | __metrics Screen width/height:1600/1200 20:00:22 INFO - PROCESS | 24318 | colorDepth:24 20:00:22 INFO - PROCESS | 24318 | Browser inner width/height: 1024/697 20:00:22 INFO - PROCESS | 24318 | __metrics 20:00:23 INFO - PROCESS | 24318 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:00:24 INFO - TEST-INFO | 24318: exit 0 20:00:24 INFO - Browser initialized. 20:00:24 INFO - Running cycle 1/1 for dromaeo_css test... 20:00:24 INFO - TEST-INFO | started process 24404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYk9Oji/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:36 INFO - PROCESS | 24404 | RSS: Main: 157626368 20:00:36 INFO - PROCESS | 24404 | 20:01:26 INFO - PROCESS | 24404 | 1467946886858 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] 20:03:35 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:37903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37903/tests/dromaeo/cssquery-ext.html) 20:03:36 INFO - PROCESS | 24404 | RSS: Main: 246132736 20:03:36 INFO - PROCESS | 24404 | 20:06:39 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:37903/tests/dromaeo/cssquery-ext.html (next: http://localhost:37903/tests/dromaeo/cssquery-jquery.html) 20:06:39 INFO - PROCESS | 24404 | RSS: Main: 254398464 20:06:39 INFO - PROCESS | 24404 | 20:09:41 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:37903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37903/tests/dromaeo/cssquery-mootools.html) 20:09:42 INFO - PROCESS | 24404 | RSS: Main: 252141568 20:09:42 INFO - PROCESS | 24404 | 20:12:44 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:37903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37903/tests/dromaeo/cssquery-prototype.html) 20:12:45 INFO - PROCESS | 24404 | RSS: Main: 239427584 20:12:45 INFO - PROCESS | 24404 | 20:15:47 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:37903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37903/tests/dromaeo/cssquery-yui.html) 20:15:48 INFO - PROCESS | 24404 | RSS: Main: 209260544 20:15:48 INFO - PROCESS | 24404 | 20:18:51 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:37903/tests/dromaeo/cssquery-yui.html (next: http://localhost:37903/tests/dromaeo/cssquery-dojo.html) 20:18:51 INFO - PROCESS | 24404 | RSS: Main: 303390720 20:18:51 INFO - PROCESS | 24404 | 20:18:51 INFO - PROCESS | 24404 | __start_tp_report 20:18:51 INFO - PROCESS | 24404 | _x_x_mozilla_page_load 20:18:51 INFO - PROCESS | 24404 | _x_x_mozilla_page_load_details 20:18:51 INFO - PROCESS | 24404 | |i|pagename|runs| 20:18:51 INFO - PROCESS | 24404 | |0;dojo.html;3051.4049760296743;3072.139800855761;3102.953455698165;3108.5181796821503;3125.5467957146216;5253.816116435925;5308.681479111256;5345.011172933006;5453.5364494018;5463.480969307914;5335.813246536372;5345.4387289334545;5356.38401583818;5400;5455.1544510600925;4832.251001094827;4889.755512224392;4928.876778080541;4935.605151587883;5125.769340379692;4962.528559786832;4979.45226025137;5016.44819069902;5033.622478314122;5043.5965122790085;4789.353437285957;4824;4837.661363704507;4870.853874383774;4893.902121957541;4840;4862.17343051682;4872.171730805771;4917.139500587418;4961.18140506816;4885.682430642032;4908.558229759339;4917.311576379309;4927.950720492785;4931.827386041471;5248.895022099575;5286.762095705702;5391.703456309901;5401.459854014606;5446.183072539111;5789.102689083199;5796.565257605696;5802.564807639444;5807.274090738658;5812;5543.1408131739645;5865.032269675498;5881.088431293157;5893.44012318829;5894.204282421861;5322.308099947021;5386.084365657808;5389.51494365509;5470.671759694431;5471.2887324647545;5977.98374276374;5987.700614969322;5989.341172471025;5991.400859913973;5991.4907232884825;5450.727463626882;5555.30558680165;5722.942770572325;5732.541396688255;5736.741846616912;5705.885882282331;5763.452472015152;5811.3316968548315;5812.476877081083;5812.94187058124;5689.118186681071;5713.285839270091;5723.914141287884;5732.6847023413275;5734.5125664319;5545.251391062236;5694.174344719992;5735.684537350402;5739.139129130664;5742.28221472316;4416.734995900192;4417.933730994037;4421.557844215553;4450.1767173073085;4457.24226881431;3923.097687531884;3949.605039496085;3951.150502641946;3975.940360894589;3979.7015223857748;5216.530512253916;5376.838694839161;5385.434529374437;5460.836174914759;5494.697791621419;5762.913556296575;5825.1844741736195;5859.970700146472;5867.207926929896;5867.266591676041;5543.944560554342;5548.500634942875;5549.445055494499;5551.056320425538;5565.749541270652;4850.927236091461;4963.528464795839;5003.574696150795;5062.7468626568525;5105.387353517602;6039.939600604026;6042;6042.909356359658;6043.8186854394435;6078.969605151946;5832.445917637818;5833.504152147115;5834.474897259267;5840.123981402823;5840.2991641003355;5743.138529220483;5880.911786323294;5922.289325280994;5941.554383421347;6027.60820546663;5651.2935883014625;5686.687232202268;5689.943100569107;5690.800821971211;5693.629914055573;5796.217510636179;5801.3908539602735;5802.448767367094;5803.245578074823;5812.94187058141;5345.625806193529;5368.651037682538;5525.171224316224;5618.073017951992;5643.887122257614;5620.100783874561;5627.155926610877;5627.43725627434;5631.155326701028;5632.605717599728;5438.347398312228;5562.276904002454;5564.888702226014;5575.414581468887;5577.3028371453565;5575.1915972184615;5647.040003199548;5649.519790817662;5674.971625141848;5751.194832723506;5527.281453411031;5553.333599968029;5556.91664625039;5563.415841336763;5568.331800184003 20:18:51 INFO - PROCESS | 24404 | |1;ext.html;625.7090452939382;637.7066549387284;639.577878600124;642.0241233325347;656.1273506236706;30991.84504077482;33210;42092.789536052354;43523;43629;45956.77021614896;46273.76863115688;46297.537024629746;46319.76840115803;46329.53670463294;8785.868211976842;8977.057408972061;8978.281737460988;8980.32647551433;8984.83197184365;8892.333075019367;8983.595738191798;8986.191242788147;8988.640454381817;8994.370394072384;9015.684451044215;9058.501782401965;9062.048484909088;9067.727968160965;9070.546472676373;8992.05583413742;9004.729858104267;9012.188902998696;9044.502552359618;9044.592993315284;8824.382293239476;8915.955420222923;8930.776730581787;8948.194662480342;8951.641934322619;42302.94242643928;42395.57604423978;42490.57509424897;42540.78729606363;42558.36162457566;3426.0578340956185;3595.388783906742;3650.0692323457347;3783.375743002401;4223.619874211305;32947.6705232947;33243.833780830944;33438.498422523684;33474;35041.64958350409;4276.358546218092;4621.1219868224925;4679.88300292492;4690.859274221779;4697.459792123881;331911.3617727656;332414;333280;335193.1566501203;336247;58237;58612;58773.706131469065;58802;58959.70520147372;60572.39427605756;61283.38716612866;61295.693521533;61399;61501;17472;17646.117694115244;17720.734188987175;17724;17731.822681773276;13708.17750934947;13712.725745485233;13747.243901585509;13789.586312410644;13798.379072941741;15138.772918406232;16717.99692018483;16903.830961690226;16923;17126.828731712772;5346.973265133727;6100.481459076028;6452.838679033061;6482.286948435668;6644.60132392058;1011.4285428732743;1013.9910788765078;1056.7252514346326;1102.8456016157745;1161.1349544589334;32216.83891580527;32519.349613008082;32758.508622370682;32781.508277375855;33399.3320133596;948.6632245552868;1194.2834299420279;1196;1249.4752204074312;1272.875091649997;17365.392211272545;17548.385806496968;17564.68264880139;17646.358286275634;17740.11299435023;536280;539785;540211;540270;540888;58450;58721.70639146777;58797.82404351889;58842;59036.11445828316;1232.4946771823509;1293.3274697157426;1341.2153889974475;1383.598756360644;1401.7897315402772;30612.693873060984;33720.662793371754;33941.151471213416;34297;34685.826570866986;49056.264156036974;49501.504984949686;49687.75156124196;49783.751081244365;49854.750726247585;382948;383390;385754;387981;389432;34162.65837341595;35000.824995875875;35271.294574108884;35677.751278705124;40081.1983760329;45985;47413;47650.76174619105;48473.75763121162;48477.272840906706;40555;41604.37593436161;41693.166136677704;42396.364054538586;43178;40893;41565.58434415738;41830;41859.58140418557;42394.78802605967;41101;41713.58286417097;42141.78929105335;42689.57310426856;42826;35757;36694.44958325681;37068.814655926544;37323.83198874072;37857.62142378541;27931.441371172055;28119.156425307272;28306.85846570754;28566.71433285724;28702.856485718272 20:18:51 INFO - PROCESS | 24404 | |2;jquery.html;377.62426385746187;378.74434756539335;396.8868872371374;397.72556935714374;404.24204616344355;18092.819071809277;19280.807191928077;20574.662646927976;20621.896890515527;20627.381178564647;12259.448324825382;12262.141650084497;15546.53360399187;19017.809821901777;20375.59248815023;5290.571545682673;5419.512243898049;5437.265969094161;5439.075357189267;5462;5767.394423585526;5864.970675146618;5931.555133364994;5937.22816033915;5954.255718035246;5452.100403433429;5833.533317334624;5881.264841894763;5886.940350736866;5887.175795388649;5652.152177173416;5710.114932185476;5733.569982251327;5741.397153298906;5743.253377060997;5586.413426590231;5913.083472061794;5913.231279933624;5914.260717410324;5921.437463440966;13529.526466573623;13746.037777355588;13884.305784710825;13909.374078166507;14173.14961102327;2328.732195797471;2344.718633763959;2376.845505042184;2592.2871210417097;2747.4505098980285;10211.591536338537;10377.636782712645;10404.16766658673;10456.94771526145;10462.633807816766;1852.908629869834;1858.3681548273653;1883.4067268810281;1897.1936926806052;1982.4944639116932;82139;86041.56979215064;86125.29511887081;87239;89067.55466222692;10260;10718.785624287471;11170.385628790333;11236.775264494665;11268.436578171058;15487.457938972082;15556.844431555766;15568.455104071303;15621.375144994074;15648.530544083696;7923.9603801981775;7938.56337901421;8022.83954320922;8196;8229.382796290301;7630.580318082448;7641.732539361095;7699.842970853614;8066.717664881701;8363.289120424832;4537.795799189044;4538.636909047268;4550.908981820345;4586.128635559233;4653.744044077541;1857.9814201857807;1865.291189348039;1928.7203355513373;1942.4755316064866;1979.158857485563;910.4491782471641;966.6230170233614;969.0890562871019;994.3437331361267;1052.2160990062453;19949;20059.29792457257;20093.49766255826;20097.698534521995;20277;993.145894530703;1009.9091081802526;1014.6955913226003;1024.1141412678128;1040.490159821682;9519.762005949906;10998;11227.775444491064;11279;11295;440466;451197;453860;457827;488759;89455.55272223597;97254;97618;98315.50842245886;98925.50537247267;459.34543275831805;463.1616773639723;479.1758175937382;480.46908166476237;480.6587323000639;10778.568857245622;10996.450177490933;11491.54033838637;11777;11863;33924;43448;43536.346954795066;45690.31464527968;46689.76655116703;56973.14540281816;57443.712781435825;59960;60054.39945600488;61119;8495.575221239036;8544.35917306217;8815.294776417742;9024.052474490347;9181.816363672822;13167.209967401986;14271.500497482539;14282.857171428153;14331.460813185098;14601.12393256408;12410.937945310216;12470.314132722788;12575.754565143856;12708.809367859674;12802.67993300175;11998.58004969822;12386.81419778686;12508.624741257778;12523.4364453598;12693.301868396957;12242.326672032767;12756.553520626734;12864.935675321938;12931.935340323238;13037.087403881636;9035.63857445721;9158;9205.447673139633;9217.124373184537;9303.953480232556;12251.828242057873;12641.988640908521;12685.556005539762;12754.234745915275;12774.61676149717 20:18:51 INFO - PROCESS | 24404 | |3;mootools.html;1287.0797379873388;1430.2062355392757;1444.8699617034465;1577.928993195306;1766.9204885780146;8082.595870206488;8415.957920210398;8428.53643049632;8669.739907802761;8674.306055515559;8400.537970411626;8583.442076265039;8588.656453741844;8589.742307730778;8600.784980375494;2007.4579863436863;2067.8242349400243;2068.141721185714;2274.1812947338944;2308.226744040748;2028.3610662641295;2261.412032871457;2328.3597010822073;2333.241696448661;2342;2285;2292.6904867842877;2313.3869524576003;2314.710661167354;2316.930492085232;1942.2619404626294;2268.104098880941;2269.4553307206315;2275.4652656625763;2277.9772202278014;2159.6328624133935;2221.389117992549;2223.044091040852;2225.8441909066373;2230.743464501587;8609.69866054685;8647.481151130953;8679.696210632661;8688.435251708619;8689.26141277992;4978.6017118630425;5105.259737338065;5111;5113.642045056848;5115.104856650071;3325.135464779175;3410.7441941854213;3445.672661097217;3486.0761898097026;3503.3693935091674;1150.6375491720082;1203.151777996519;1215.7325388414536;1216.8843959823803;1235.1168914226282;11932.224405413706;11946.522139114424;11952.70118247042;11958;11973.40132993347;4302.096559722493;4343.869683909487;4497.05561832019;4526.411566496335;4528.298113792367;10064.194864410829;10071.949640251752;10074.294799363974;10078.647247346455;10082.949585252027;5052.343195384577;5072.54347108762;5072.822451214263;5074.441811400743;5075;4066.0233419858664;4450.221211288012;4673.556012178838;4690.742009189527;4691.7888695008805;3844.8654297100024;3950.308695978192;4028.7784171870244;4053.61490658387;4055.655269302142;1222.9021678265717;1236.097648716442;1248.9188202766973;1266.7339858629607;1283.4417028592593;877.9165979231963;983.0611765763679;988.367444835306;999.6051559633904;1007.4761124215513;5915.319738230159;5937.287525496881;6046.939530604725;6069.387107018056;6177.227846519185;452.3802390724662;458.17071101306743;460.24060300504436;1031.9019693129142;1054.1619412567027;4208.452901122834;4236.978815105905;4264.253755592821;4287.978560107242;4301.548337424588;10622.628208012682;10666.306690065121;10718.088962438123;10903.182261330432;10912.781744365067;10704.78590428187;10714.035736783728;10729;10729.141668666643;10729.892701073046;7659.310662040443;7948;7956.403269754907;8031.55826429552;8181.959090204511;5859.853503662272;6140.938590614037;6156.230471191101;6188.907166392598;6209.348018458178;9304.95347523258;9592.856107158537;9615.615375385187;9904.25718071133;10151.238657100599;9754.75613109678;9933.801323973335;9985.60057597688;10122.190224781853;10127.64553240633;7116.074910261633;7338.522996005243;7644.388448924184;7787.805304867197;7965.840683186188;8570.957145214234;8572.142785721628;8601.268892144239;8633.266172375168;8639.438436501607;7576.8484630308185;7708.113566939649;7731.806704832424;7847.921520784719;7886.526808391285;7295.088113985752;7450.105987281344;7460.477766556506;7656.770296891103;7814.101378341564;6763.357481039294;6852.45180385558;6862.862742745217;6873.1064961554675;6901.551399159039;5146.485351464824;5278.683279003272;5320.068987927175;5323.3878104016985;5395.24466574672;5098.629137451103;5174.7930082796265;5300.125479296027;5354.250404943233;5391.406945236099 20:18:51 INFO - PROCESS | 24404 | |4;prototype.html;315.08782075890315;327.5316297694297;332.466391441736;332.9650386709397;334.28296304427005;5243.711595862226;5244.79020839167;5268.05175068488;5273.314469119009;5288.365396152462;4984.675996060254;5037.798488060474;5197.324347834786;5225.8954820903555;5233.3981592116825;4117.855875044374;4147.776405960249;4152.958470415288;4154.439150714653;4160.979195104035;4147.543770185277;4150.833966641346;4162.1675664867;4165.520965089023;4167.812448439812;3877.592852750463;4032.3749818777987;4120.484939382577;4122.319817230154;4144.626983571478;4097.67218622511;4113.6297733203855;4113.958860411388;4118.5263694675195;4140.275451795938;3683.852645894161;3688.5798967397477;3694.11341278094;3695.2609478104487;3704.481372607837;4934.481879402683;5067.239914012891;5081.2632168335385;5111.923321150149;5143.459936706667;4688.671792974493;4690.859274221779;4700.4359476862655;4704.600108990706;4715.528447155291;5407.242985981966;5413.675179489243;5426.104692725696;5431.592630552685;5450.591205659592;3901.51231096113;4019.6132334344607;4023.839046438139;4035.6973227008093;4056.574059723716;5657.688827114507;5660.886782264372;5669.348024977139;5671.574631902624;5703.914441283343;4096.713230073866;4098.877033688994;4100.938485922714;4103.461202049231;4114.362273847559;3981.6217459341315;4148.502179738391;4153.293940030202;4156.441334499563;4163.6669066475215;4655.4180727409075;4691.366665500182;4694.755889689235;4701.764911754399;4705.623550115983;5448.665077056146;5459.0173768721215;5488.643238189505;5495.527012844236;5528.944710552843;1322.816079608764;1359.959201223945;1434.6556826361598;1443.2783608195903;1450.8103355248595;990.8513722941616;1001.3841487485145;1009.6112996496402;1010.570507534295;1016.8627235323285;5180.673654979519;5252.947470525322;5288.550473209743;5292.497212764782;5305.469453054741;5502.889942201134;5534.308211473566;5547.2511210986;5550.306211723535;5553.361363443175;5132.358455193101;5217.295665085241;5250.868728281824;5252.448492908266;5255.76349064293;2623.7304731407194;2663.9600405993924;2677.7322267773457;2682.6646669166353;2702.7972902032425;5075.289459475676;5080.542751152414;5081.771320290596;5103.157978933435;5161.2516185152945;4838.749981258731;5014.749262536859;5034.949650503448;5042.268871013683;5055.418626857885;5060.240963855451;5107.9489205107475;5113.079645663742;5128.230765385148;5130.384353877558;4885.509919474594;4897.873489097598;4899.632527560376;4935.802567897387;4941.703497790144;4833.685810422311;4878.243872199815;4905.975470122627;5204.739763011758;5631.831045068655;5837.3870743571315;5848.152017957457;5851.678157701367;5852.853678657897;5865.384134665798;3858.9807050964564;3922.9607703922597;3973.8807835764974;3981.4425980363353;3982.2433737589763;5562.443755624405;5588.211772232847;5615.719214039364;5658.858528536654;5665.093585026376;5444.128939369682;5446.700431476148;5466.671999680032;5521.337439507285;5528.364238112668;5371.382291036581;5481.972590137024;5501.724913754216;5505.201745746765;5523.226748255167;5425.321834770653;5440.619156658996;5444.713220447501;5445.346558413015;5456.945430545803;5403.702796346239;5527.5577953764405;5539.279893613804;5543.584231182758;5544.833654990357;5405.891882162414;5409.29679141709;5415.512603865671;5427.4301198373605;5433.212184233343 20:18:51 INFO - PROCESS | 24404 | |5;yui.html;811.3063330852121;828;838.9035260944993;841.920017598328;843.3716880923711;14566.49017284394;15590.064596124226;15606.531804045868;15633.687326253468;16623.251953662086;15898.443554475596;16196.919015404907;16249.431269905555;16271.755923661154;16289.185540722947;679.3953381490477;821.3142026407957;833.5582141465034;837.426362941384;838.5136620759945;799.5962039170211;824.6701319472229;826.4710585225431;832.0514613340796;833.7332053742774;867.9974629303165;868.7524055644143;871.8910136232971;875.1948207648946;876.8860048193726;698.6122701900495;837.2966707965338;859.0335872143838;863.6286396849353;864.2999170671744;626.4424662050778;630.1933525087895;630.391672036487;631.0723236841835;631.1258906414603;13440.462381504729;13454.327283635877;13475.326233688374;13558.661033474144;13584.796228056586;14991.775123373158;15408;15447.227638618024;15476.380944762195;15564.533064008097;13873;13991.510297139654;14091.647708807259;14125.364358603887;14745.70508589833;4625.306204069383;4649.232876575361;4717.575418212377;4733.857984260478;4839.322494850724;62787;88506.5574672129;88650.11349886483;90701;94407.05592944051;12213.755724885452;12242.243087174287;12362.320072396105;12421.565245216554;12722.854943054985;23575.88212058963;23675.7632423677;23735.406614834767;23880.522389552112;23944.640830387558;8935;9045.592948317342;9147.496887671108;9241.537923103819;9381.718548443558;4951.257311403318;4962.950370496321;5057.620678449058;5110.540051395392;5152.433232344439;3440.2431465077643;3547.8935631930567;3559.9288014240087;3560.839762210707;3562.323158599858;584.2346526050887;584.6993720448131;596.0969131765379;606.0757345048836;608.342989571262;537.4705914674043;652.4584594786317;711.9394851437582;730.3280981497036;741.2365263778318;9057.304987212217;9813.362131461432;9829.115379615869;9839.3112482127;10065.849012264822;621.4996927473427;626.8996960486301;645.6578013652771;695.544418405945;774.9612519374122;4937.136001199776;5001.899962000813;5016.673916195508;5021.949780502148;5024.145895197825;65997.34002660008;84399.57800211082;107903.46048269709;116912;117297;99327;99671.50164249132;103640.48179759053;103760;105625.47187264015;78018;78488;79555.60222198968;83258.58370708108;92431.53784231035;9920.399842691188;10228.028337307944;10358.171346292429;10617.203709721647;10831.18766092562;45056.77471612621;48859.511404885496;50795;54753.45246547643;57088;80573.59713201397;81966;82030.17969820225;82255.5887220584;83188.58405707932;14667.119972801665;14997.925010374878;15089.773653395427;15172.914532379773;15366.385344586091;16103.194840257705;16231.837681623505;16328.67342653164;16347.264373103;16946.237419315912;14396.568102956928;14712.190829504052;14742.894282928608;14792.260386980823;14937.551873443814;13765.793513097511;13994.790078148631;14226.715465690835;14453.566393008226;14986.625334366729;14262;14288;14370.712585748017;14559.92720036393;14571.344289506786;11655.125865560287;11739.47172377228;11742.765144696887;12069.758604827679;12523.93738031304;11974.521019159136;12270.202436841577;12280.201786883825;12692.301923394301;12739.29933853647 20:18:51 INFO - PROCESS | 24404 | __end_tp_report 20:18:51 INFO - PROCESS | 24404 | __start_cc_report 20:18:51 INFO - PROCESS | 24404 | _x_x_mozilla_cycle_collect,797 20:18:51 INFO - PROCESS | 24404 | __end_cc_report 20:18:51 INFO - PROCESS | 24404 | __startTimestamp1467947931566__endTimestamp 20:18:51 INFO - PROCESS | 24404 | 20:18:51 INFO - PROCESS | 24404 | ------- Summary: start ------- 20:18:51 INFO - PROCESS | 24404 | Number of tests: 6 20:18:51 INFO - PROCESS | 24404 | 20:18:51 INFO - PROCESS | 24404 | [#0] dojo.html Cycles:165 Average:5362.18 Median:5553.33 stddev:612.89 (11.0%) stddev-sans-first:587.35 20:18:51 INFO - PROCESS | 24404 | Values: 3051.4 3072.1 3103.0 3108.5 3125.5 5253.8 5308.7 5345.0 5453.5 5463.5 5335.8 5345.4 5356.4 5400.0 5455.2 4832.3 4889.8 4928.9 4935.6 5125.8 4962.5 4979.5 5016.4 5033.6 5043.6 4789.4 4824.0 4837.7 4870.9 4893.9 4840.0 4862.2 4872.2 4917.1 4961.2 4885.7 4908.6 4917.3 4928.0 4931.8 5248.9 5286.8 5391.7 5401.5 5446.2 5789.1 5796.6 5802.6 5807.3 5812.0 5543.1 5865.0 5881.1 5893.4 5894.2 5322.3 5386.1 5389.5 5470.7 5471.3 5978.0 5987.7 5989.3 5991.4 5991.5 5450.7 5555.3 5722.9 5732.5 5736.7 5705.9 5763.5 5811.3 5812.5 5812.9 5689.1 5713.3 5723.9 5732.7 5734.5 5545.3 5694.2 5735.7 5739.1 5742.3 4416.7 4417.9 4421.6 4450.2 4457.2 3923.1 3949.6 3951.2 3975.9 3979.7 5216.5 5376.8 5385.4 5460.8 5494.7 5762.9 5825.2 5860.0 5867.2 5867.3 5543.9 5548.5 5549.4 5551.1 5565.7 4850.9 4963.5 5003.6 5062.7 5105.4 6039.9 6042.0 6042.9 6043.8 6079.0 5832.4 5833.5 5834.5 5840.1 5840.3 5743.1 5880.9 5922.3 5941.6 6027.6 5651.3 5686.7 5689.9 5690.8 5693.6 5796.2 5801.4 5802.4 5803.2 5812.9 5345.6 5368.7 5525.2 5618.1 5643.9 5620.1 5627.2 5627.4 5631.2 5632.6 5438.3 5562.3 5564.9 5575.4 5577.3 5575.2 5647.0 5649.5 5675.0 5751.2 5527.3 5553.3 5556.9 5563.4 5568.3 20:18:51 INFO - PROCESS | 24404 | 20:18:51 INFO - PROCESS | 24404 | [#1] ext.html Cycles:180 Average:58844.78 Median:23182.70 stddev:113503.42 (489.6%) stddev-sans-first:113737.66 20:18:51 INFO - PROCESS | 24404 | Values: 625.7 637.7 639.6 642.0 656.1 30991.8 33210.0 42092.8 43523.0 43629.0 45956.8 46273.8 46297.5 46319.8 46329.5 8785.9 8977.1 8978.3 8980.3 8984.8 8892.3 8983.6 8986.2 8988.6 8994.4 9015.7 9058.5 9062.0 9067.7 9070.5 8992.1 9004.7 9012.2 9044.5 9044.6 8824.4 8916.0 8930.8 8948.2 8951.6 42302.9 42395.6 42490.6 42540.8 42558.4 3426.1 3595.4 3650.1 3783.4 4223.6 32947.7 33243.8 33438.5 33474.0 35041.6 4276.4 4621.1 4679.9 4690.9 4697.5 331911.4 332414.0 333280.0 335193.2 336247.0 58237.0 58612.0 58773.7 58802.0 58959.7 60572.4 61283.4 61295.7 61399.0 61501.0 17472.0 17646.1 17720.7 17724.0 17731.8 13708.2 13712.7 13747.2 13789.6 13798.4 15138.8 16718.0 16903.8 16923.0 17126.8 5347.0 6100.5 6452.8 6482.3 6644.6 1011.4 1014.0 1056.7 1102.8 1161.1 32216.8 32519.3 32758.5 32781.5 33399.3 948.7 1194.3 1196.0 1249.5 1272.9 17365.4 17548.4 17564.7 17646.4 17740.1 536280.0 539785.0 540211.0 540270.0 540888.0 58450.0 58721.7 58797.8 58842.0 59036.1 1232.5 1293.3 1341.2 1383.6 1401.8 30612.7 33720.7 33941.2 34297.0 34685.8 49056.3 49501.5 49687.8 49783.8 49854.8 382948.0 383390.0 385754.0 387981.0 389432.0 34162.7 35000.8 35271.3 35677.8 40081.2 45985.0 47413.0 47650.8 48473.8 48477.3 40555.0 41604.4 41693.2 42396.4 43178.0 40893.0 41565.6 41830.0 41859.6 42394.8 41101.0 41713.6 42141.8 42689.6 42826.0 35757.0 36694.4 37068.8 37323.8 37857.6 27931.4 28119.2 28306.9 28566.7 28702.9 20:18:51 INFO - PROCESS | 24404 | 20:18:51 INFO - PROCESS | 24404 | [#2] jquery.html Cycles:180 Average:28119.02 Median:378.18 stddev:76094.44 (20121.0%) stddev-sans-first:76279.40 20:18:51 INFO - PROCESS | 24404 | Values: 377.6 378.7 396.9 397.7 404.2 18092.8 19280.8 20574.7 20621.9 20627.4 12259.4 12262.1 15546.5 19017.8 20375.6 5290.6 5419.5 5437.3 5439.1 5462.0 5767.4 5865.0 5931.6 5937.2 5954.3 5452.1 5833.5 5881.3 5886.9 5887.2 5652.2 5710.1 5733.6 5741.4 5743.3 5586.4 5913.1 5913.2 5914.3 5921.4 13529.5 13746.0 13884.3 13909.4 14173.1 2328.7 2344.7 2376.8 2592.3 2747.5 10211.6 10377.6 10404.2 10456.9 10462.6 1852.9 1858.4 1883.4 1897.2 1982.5 82139.0 86041.6 86125.3 87239.0 89067.6 10260.0 10718.8 11170.4 11236.8 11268.4 15487.5 15556.8 15568.5 15621.4 15648.5 7924.0 7938.6 8022.8 8196.0 8229.4 7630.6 7641.7 7699.8 8066.7 8363.3 4537.8 4538.6 4550.9 4586.1 4653.7 1858.0 1865.3 1928.7 1942.5 1979.2 910.4 966.6 969.1 994.3 1052.2 19949.0 20059.3 20093.5 20097.7 20277.0 993.1 1009.9 1014.7 1024.1 1040.5 9519.8 10998.0 11227.8 11279.0 11295.0 440466.0 451197.0 453860.0 457827.0 488759.0 89455.6 97254.0 97618.0 98315.5 98925.5 459.3 463.2 479.2 480.5 480.7 10778.6 10996.5 11491.5 11777.0 11863.0 33924.0 43448.0 43536.3 45690.3 46689.8 56973.1 57443.7 59960.0 60054.4 61119.0 8495.6 8544.4 8815.3 9024.1 9181.8 13167.2 14271.5 14282.9 14331.5 14601.1 12410.9 12470.3 12575.8 12708.8 12802.7 11998.6 12386.8 12508.6 12523.4 12693.3 12242.3 12756.6 12864.9 12931.9 13037.1 9035.6 9158.0 9205.4 9217.1 9304.0 12251.8 12642.0 12685.6 12754.2 12774.6 20:18:51 INFO - PROCESS | 24404 | 20:18:51 INFO - PROCESS | 24404 | [#3] mootools.html Cycles:180 Average:5704.99 Median:2566.90 stddev:3234.78 (126.0%) stddev-sans-first:3226.82 20:18:51 INFO - PROCESS | 24404 | Values: 1287.1 1430.2 1444.9 1577.9 1766.9 8082.6 8416.0 8428.5 8669.7 8674.3 8400.5 8583.4 8588.7 8589.7 8600.8 2007.5 2067.8 2068.1 2274.2 2308.2 2028.4 2261.4 2328.4 2333.2 2342.0 2285.0 2292.7 2313.4 2314.7 2316.9 1942.3 2268.1 2269.5 2275.5 2278.0 2159.6 2221.4 2223.0 2225.8 2230.7 8609.7 8647.5 8679.7 8688.4 8689.3 4978.6 5105.3 5111.0 5113.6 5115.1 3325.1 3410.7 3445.7 3486.1 3503.4 1150.6 1203.2 1215.7 1216.9 1235.1 11932.2 11946.5 11952.7 11958.0 11973.4 4302.1 4343.9 4497.1 4526.4 4528.3 10064.2 10071.9 10074.3 10078.6 10082.9 5052.3 5072.5 5072.8 5074.4 5075.0 4066.0 4450.2 4673.6 4690.7 4691.8 3844.9 3950.3 4028.8 4053.6 4055.7 1222.9 1236.1 1248.9 1266.7 1283.4 877.9 983.1 988.4 999.6 1007.5 5915.3 5937.3 6046.9 6069.4 6177.2 452.4 458.2 460.2 1031.9 1054.2 4208.5 4237.0 4264.3 4288.0 4301.5 10622.6 10666.3 10718.1 10903.2 10912.8 10704.8 10714.0 10729.0 10729.1 10729.9 7659.3 7948.0 7956.4 8031.6 8182.0 5859.9 6140.9 6156.2 6188.9 6209.3 9305.0 9592.9 9615.6 9904.3 10151.2 9754.8 9933.8 9985.6 10122.2 10127.6 7116.1 7338.5 7644.4 7787.8 7965.8 8571.0 8572.1 8601.3 8633.3 8639.4 7576.8 7708.1 7731.8 7847.9 7886.5 7295.1 7450.1 7460.5 7656.8 7814.1 6763.4 6852.5 6862.9 6873.1 6901.6 5146.5 5278.7 5320.1 5323.4 5395.2 5098.6 5174.8 5300.1 5354.3 5391.4 20:18:51 INFO - PROCESS | 24404 | 20:18:51 INFO - PROCESS | 24404 | [#4] prototype.html Cycles:180 Average:4534.12 Median:5063.74 stddev:1302.83 (25.7%) stddev-sans-first:1267.42 20:18:51 INFO - PROCESS | 24404 | Values: 315.1 327.5 332.5 333.0 334.3 5243.7 5244.8 5268.1 5273.3 5288.4 4984.7 5037.8 5197.3 5225.9 5233.4 4117.9 4147.8 4153.0 4154.4 4161.0 4147.5 4150.8 4162.2 4165.5 4167.8 3877.6 4032.4 4120.5 4122.3 4144.6 4097.7 4113.6 4114.0 4118.5 4140.3 3683.9 3688.6 3694.1 3695.3 3704.5 4934.5 5067.2 5081.3 5111.9 5143.5 4688.7 4690.9 4700.4 4704.6 4715.5 5407.2 5413.7 5426.1 5431.6 5450.6 3901.5 4019.6 4023.8 4035.7 4056.6 5657.7 5660.9 5669.3 5671.6 5703.9 4096.7 4098.9 4100.9 4103.5 4114.4 3981.6 4148.5 4153.3 4156.4 4163.7 4655.4 4691.4 4694.8 4701.8 4705.6 5448.7 5459.0 5488.6 5495.5 5528.9 1322.8 1360.0 1434.7 1443.3 1450.8 990.9 1001.4 1009.6 1010.6 1016.9 5180.7 5252.9 5288.6 5292.5 5305.5 5502.9 5534.3 5547.3 5550.3 5553.4 5132.4 5217.3 5250.9 5252.4 5255.8 2623.7 2664.0 2677.7 2682.7 2702.8 5075.3 5080.5 5081.8 5103.2 5161.3 4838.7 5014.7 5034.9 5042.3 5055.4 5060.2 5107.9 5113.1 5128.2 5130.4 4885.5 4897.9 4899.6 4935.8 4941.7 4833.7 4878.2 4906.0 5204.7 5631.8 5837.4 5848.2 5851.7 5852.9 5865.4 3859.0 3923.0 3973.9 3981.4 3982.2 5562.4 5588.2 5615.7 5658.9 5665.1 5444.1 5446.7 5466.7 5521.3 5528.4 5371.4 5482.0 5501.7 5505.2 5523.2 5425.3 5440.6 5444.7 5445.3 5456.9 5403.7 5527.6 5539.3 5543.6 5544.8 5405.9 5409.3 5415.5 5427.4 5433.2 20:18:51 INFO - PROCESS | 24404 | 20:18:51 INFO - PROCESS | 24404 | [#5] yui.html Cycles:180 Average:21279.21 Median:4786.59 stddev:29655.32 (619.6%) stddev-sans-first:29698.69 20:18:51 INFO - PROCESS | 24404 | Values: 811.3 828.0 838.9 841.9 843.4 14566.5 15590.1 15606.5 15633.7 16623.3 15898.4 16196.9 16249.4 16271.8 16289.2 679.4 821.3 833.6 837.4 838.5 799.6 824.7 826.5 832.1 833.7 868.0 868.8 871.9 875.2 876.9 698.6 837.3 859.0 863.6 864.3 626.4 630.2 630.4 631.1 631.1 13440.5 13454.3 13475.3 13558.7 13584.8 14991.8 15408.0 15447.2 15476.4 15564.5 13873.0 13991.5 14091.6 14125.4 14745.7 4625.3 4649.2 4717.6 4733.9 4839.3 62787.0 88506.6 88650.1 90701.0 94407.1 12213.8 12242.2 12362.3 12421.6 12722.9 23575.9 23675.8 23735.4 23880.5 23944.6 8935.0 9045.6 9147.5 9241.5 9381.7 4951.3 4963.0 5057.6 5110.5 5152.4 3440.2 3547.9 3559.9 3560.8 3562.3 584.2 584.7 596.1 606.1 608.3 537.5 652.5 711.9 730.3 741.2 9057.3 9813.4 9829.1 9839.3 10065.8 621.5 626.9 645.7 695.5 775.0 4937.1 5001.9 5016.7 5021.9 5024.1 65997.3 84399.6 107903.5 116912.0 117297.0 99327.0 99671.5 103640.5 103760.0 105625.5 78018.0 78488.0 79555.6 83258.6 92431.5 9920.4 10228.0 10358.2 10617.2 10831.2 45056.8 48859.5 50795.0 54753.5 57088.0 80573.6 81966.0 82030.2 82255.6 83188.6 14667.1 14997.9 15089.8 15172.9 15366.4 16103.2 16231.8 16328.7 16347.3 16946.2 14396.6 14712.2 14742.9 14792.3 14937.6 13765.8 13994.8 14226.7 14453.6 14986.6 14262.0 14288.0 14370.7 14559.9 14571.3 11655.1 11739.5 11742.8 12069.8 12523.9 11974.5 12270.2 12280.2 12692.3 12739.3 20:18:51 INFO - PROCESS | 24404 | -------- Summary: end -------- 20:18:51 INFO - PROCESS | 24404 | 20:18:52 INFO - TEST-INFO | 24404: exit 0 20:18:52 INFO - TEST-OK | dromaeo_css | took 1113972ms 20:18:52 INFO - TEST-START | kraken 20:18:52 INFO - operating with platform_type : linux_ 20:18:52 INFO - Initialising browser for kraken test... 20:18:52 INFO - TEST-INFO | started process 24598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMI6R4/profile http://localhost:37903/getInfo.html) 20:18:56 INFO - PROCESS | 24598 | __metrics Screen width/height:1600/1200 20:18:56 INFO - PROCESS | 24598 | colorDepth:24 20:18:56 INFO - PROCESS | 24598 | Browser inner width/height: 1024/697 20:18:56 INFO - PROCESS | 24598 | __metrics 20:18:57 INFO - PROCESS | 24598 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:18:58 INFO - TEST-INFO | 24598: exit 0 20:18:58 INFO - Browser initialized. 20:18:58 INFO - Running cycle 1/1 for kraken test... 20:18:58 INFO - TEST-INFO | started process 24684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMI6R4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:09 INFO - PROCESS | 24684 | RSS: Main: 157433856 20:19:09 INFO - PROCESS | 24684 | 20:19:12 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37903/tests/kraken/driver.html?testName=audio-beat-detection) 20:19:13 INFO - PROCESS | 24684 | RSS: Main: 215187456 20:19:13 INFO - PROCESS | 24684 | 20:19:15 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37903/tests/kraken/driver.html?testName=audio-dft) 20:19:16 INFO - PROCESS | 24684 | RSS: Main: 203366400 20:19:16 INFO - PROCESS | 24684 | 20:19:19 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37903/tests/kraken/driver.html?testName=audio-fft) 20:19:20 INFO - PROCESS | 24684 | RSS: Main: 269705216 20:19:20 INFO - PROCESS | 24684 | 20:19:22 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37903/tests/kraken/driver.html?testName=audio-oscillator) 20:19:22 INFO - PROCESS | 24684 | RSS: Main: 179900416 20:19:22 INFO - PROCESS | 24684 | 20:19:25 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:19:25 INFO - PROCESS | 24684 | RSS: Main: 184168448 20:19:25 INFO - PROCESS | 24684 | 20:19:28 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37903/tests/kraken/driver.html?testName=imaging-darkroom) 20:19:29 INFO - PROCESS | 24684 | RSS: Main: 219312128 20:19:29 INFO - PROCESS | 24684 | 20:19:32 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37903/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:33 INFO - PROCESS | 24684 | RSS: Main: 220590080 20:19:33 INFO - PROCESS | 24684 | 20:19:35 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37903/tests/kraken/driver.html?testName=json-parse-financial) 20:19:36 INFO - PROCESS | 24684 | RSS: Main: 221712384 20:19:36 INFO - PROCESS | 24684 | 20:19:38 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:38 INFO - PROCESS | 24684 | RSS: Main: 207273984 20:19:38 INFO - PROCESS | 24684 | 20:19:40 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37903/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:41 INFO - PROCESS | 24684 | RSS: Main: 211873792 20:19:41 INFO - PROCESS | 24684 | 20:19:43 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:43 INFO - PROCESS | 24684 | RSS: Main: 209772544 20:19:43 INFO - PROCESS | 24684 | 20:19:46 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:46 INFO - PROCESS | 24684 | RSS: Main: 224382976 20:19:46 INFO - PROCESS | 24684 | 20:19:49 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:50 INFO - PROCESS | 24684 | RSS: Main: 224456704 20:19:50 INFO - PROCESS | 24684 | 20:19:51 INFO - PROCESS | 24684 | Cycle 1(1): loaded http://localhost:37903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37903/tests/kraken/driver.html?testName=ai-astar) 20:19:52 INFO - PROCESS | 24684 | RSS: Main: 266514432 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | __start_tp_report 20:19:52 INFO - PROCESS | 24684 | _x_x_mozilla_page_load 20:19:52 INFO - PROCESS | 24684 | _x_x_mozilla_page_load_details 20:19:52 INFO - PROCESS | 24684 | |i|pagename|runs| 20:19:52 INFO - PROCESS | 24684 | |0;ai-astar;102;112;109;110;112;109;110;111;112;110 20:19:52 INFO - PROCESS | 24684 | |1;audio-beat-detection;145;116;117;170;124;117;147;117;148;120 20:19:52 INFO - PROCESS | 24684 | |2;audio-dft;160;160;160;160;160;160;161;162;160;160 20:19:52 INFO - PROCESS | 24684 | |3;audio-fft;75;74;74;116;74;75;74;73;100;74 20:19:52 INFO - PROCESS | 24684 | |4;audio-oscillator;84;84;116;83;84;84;120;84;85;125 20:19:52 INFO - PROCESS | 24684 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;118;117;117 20:19:52 INFO - PROCESS | 24684 | |6;imaging-darkroom;145;145;146;146;146;146;146;145;145;145 20:19:52 INFO - PROCESS | 24684 | |7;imaging-desaturate;95;97;96;95;95;95;95;95;96;95 20:19:52 INFO - PROCESS | 24684 | |8;json-parse-financial;53;53;52;53;52;52;53;53;52;53 20:19:52 INFO - PROCESS | 24684 | |9;json-stringify-tinderbox;60;61;61;61;61;61;61;61;60;61 20:19:52 INFO - PROCESS | 24684 | |10;stanford-crypto-aes;75;75;74;74;74;74;74;76;74;83 20:19:52 INFO - PROCESS | 24684 | |11;stanford-crypto-ccm;124;124;137;119;118;118;121;119;186;120 20:19:52 INFO - PROCESS | 24684 | |12;stanford-crypto-pbkdf2;158;157;162;157;153;153;153;155;154;158 20:19:52 INFO - PROCESS | 24684 | |13;stanford-crypto-sha256-iterative;63;62;66;62;64;64;62;62;64;62 20:19:52 INFO - PROCESS | 24684 | __end_tp_report 20:19:52 INFO - PROCESS | 24684 | __start_cc_report 20:19:52 INFO - PROCESS | 24684 | _x_x_mozilla_cycle_collect,1649 20:19:52 INFO - PROCESS | 24684 | __end_cc_report 20:19:52 INFO - PROCESS | 24684 | __startTimestamp1467947992037__endTimestamp 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | ------- Summary: start ------- 20:19:52 INFO - PROCESS | 24684 | Number of tests: 14 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.95 (2.7%) stddev-sans-first:1.24 20:19:52 INFO - PROCESS | 24684 | Values: 102.0 112.0 109.0 110.0 112.0 109.0 110.0 111.0 112.0 110.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:134.50 stddev:18.95 (14.1%) stddev-sans-first:19.52 20:19:52 INFO - PROCESS | 24684 | Values: 145.0 116.0 117.0 170.0 124.0 117.0 147.0 117.0 148.0 120.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 20:19:52 INFO - PROCESS | 24684 | Values: 160.0 160.0 160.0 160.0 160.0 160.0 161.0 162.0 160.0 160.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.00 stddev:14.78 (20.0%) stddev-sans-first:15.53 20:19:52 INFO - PROCESS | 24684 | Values: 75.0 74.0 74.0 116.0 74.0 75.0 74.0 73.0 100.0 74.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:17.69 (21.1%) stddev-sans-first:18.31 20:19:52 INFO - PROCESS | 24684 | Values: 84.0 84.0 116.0 83.0 84.0 84.0 120.0 84.0 85.0 125.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 20:19:52 INFO - PROCESS | 24684 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:19:52 INFO - PROCESS | 24684 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 20:19:52 INFO - PROCESS | 24684 | Values: 95.0 97.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.52 (1.0%) stddev-sans-first:0.53 20:19:52 INFO - PROCESS | 24684 | Values: 53.0 53.0 52.0 53.0 52.0 52.0 53.0 53.0 52.0 53.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 20:19:52 INFO - PROCESS | 24684 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:74.50 stddev:2.79 (3.7%) stddev-sans-first:2.96 20:19:52 INFO - PROCESS | 24684 | Values: 75.0 75.0 74.0 74.0 74.0 74.0 74.0 76.0 74.0 83.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:122.50 stddev:20.95 (17.1%) stddev-sans-first:22.15 20:19:52 INFO - PROCESS | 24684 | Values: 124.0 124.0 137.0 119.0 118.0 118.0 121.0 119.0 186.0 120.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:157.00 stddev:2.94 (1.9%) stddev-sans-first:3.03 20:19:52 INFO - PROCESS | 24684 | Values: 158.0 157.0 162.0 157.0 153.0 153.0 153.0 155.0 154.0 158.0 20:19:52 INFO - PROCESS | 24684 | 20:19:52 INFO - PROCESS | 24684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.37 (2.2%) stddev-sans-first:1.45 20:19:52 INFO - PROCESS | 24684 | Values: 63.0 62.0 66.0 62.0 64.0 64.0 62.0 62.0 64.0 62.0 20:19:52 INFO - PROCESS | 24684 | -------- Summary: end -------- 20:19:52 INFO - PROCESS | 24684 | 20:19:53 INFO - TEST-INFO | 24684: exit 0 20:19:53 INFO - TEST-OK | kraken | took 60791ms 20:19:53 INFO - SUITE-END | took 1174s 20:19:53 INFO - Completed test suite (00:19:34) 20:19:53 INFO - javascript benchmark 20:19:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3051.4049760296743, 3072.139800855761, 3102.953455698165, 3108.5181796821503, 3125.5467957146216, 5253.816116435925, 5308.681479111256, 5345.011172933006, 5453.5364494018, 5463.480969307914, 5335.813246536372, 5345.4387289334545, 5356.38401583818, 5400.0, 5455.1544510600925, 4832.251001094827, 4889.755512224392, 4928.876778080541, 4935.605151587883, 5125.769340379692, 4962.528559786832, 4979.45226025137, 5016.44819069902, 5033.622478314122, 5043.5965122790085, 4789.353437285957, 4824.0, 4837.661363704507, 4870.853874383774, 4893.902121957541, 4840.0, 4862.17343051682, 4872.171730805771, 4917.139500587418, 4961.18140506816, 4885.682430642032, 4908.558229759339, 4917.311576379309, 4927.950720492785, 4931.827386041471, 5248.895022099575, 5286.762095705702, 5391.703456309901, 5401.459854014606, 5446.183072539111, 5789.102689083199, 5796.565257605696, 5802.564807639444, 5807.274090738658, 5812.0, 5543.1408131739645, 5865.032269675498, 5881.088431293157, 5893.44012318829, 5894.204282421861, 5322.308099947021, 5386.084365657808, 5389.51494365509, 5470.671759694431, 5471.2887324647545, 5977.98374276374, 5987.700614969322, 5989.341172471025, 5991.400859913973, 5991.4907232884825, 5450.727463626882, 5555.30558680165, 5722.942770572325, 5732.541396688255, 5736.741846616912, 5705.885882282331, 5763.452472015152, 5811.3316968548315, 5812.476877081083, 5812.94187058124, 5689.118186681071, 5713.285839270091, 5723.914141287884, 5732.6847023413275, 5734.5125664319, 5545.251391062236, 5694.174344719992, 5735.684537350402, 5739.139129130664, 5742.28221472316, 4416.734995900192, 4417.933730994037, 4421.557844215553, 4450.1767173073085, 4457.24226881431, 3923.097687531884, 3949.605039496085, 3951.150502641946, 3975.940360894589, 3979.7015223857748, 5216.530512253916, 5376.838694839161, 5385.434529374437, 5460.836174914759, 5494.697791621419, 5762.913556296575, 5825.1844741736195, 5859.970700146472, 5867.207926929896, 5867.266591676041, 5543.944560554342, 5548.500634942875, 5549.445055494499, 5551.056320425538, 5565.749541270652, 4850.927236091461, 4963.528464795839, 5003.574696150795, 5062.7468626568525, 5105.387353517602, 6039.939600604026, 6042.0, 6042.909356359658, 6043.8186854394435, 6078.969605151946, 5832.445917637818, 5833.504152147115, 5834.474897259267, 5840.123981402823, 5840.2991641003355, 5743.138529220483, 5880.911786323294, 5922.289325280994, 5941.554383421347, 6027.60820546663, 5651.2935883014625, 5686.687232202268, 5689.943100569107, 5690.800821971211, 5693.629914055573, 5796.217510636179, 5801.3908539602735, 5802.448767367094, 5803.245578074823, 5812.94187058141, 5345.625806193529, 5368.651037682538, 5525.171224316224, 5618.073017951992, 5643.887122257614, 5620.100783874561, 5627.155926610877, 5627.43725627434, 5631.155326701028, 5632.605717599728, 5438.347398312228, 5562.276904002454, 5564.888702226014, 5575.414581468887, 5577.3028371453565, 5575.1915972184615, 5647.040003199548, 5649.519790817662, 5674.971625141848, 5751.194832723506, 5527.281453411031, 5553.333599968029, 5556.91664625039, 5563.415841336763, 5568.331800184003], "value": 5320.533632988784, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.7090452939382, 637.7066549387284, 639.577878600124, 642.0241233325347, 656.1273506236706, 30991.84504077482, 33210.0, 42092.789536052354, 43523.0, 43629.0, 45956.77021614896, 46273.76863115688, 46297.537024629746, 46319.76840115803, 46329.53670463294, 8785.868211976842, 8977.057408972061, 8978.281737460988, 8980.32647551433, 8984.83197184365, 8892.333075019367, 8983.595738191798, 8986.191242788147, 8988.640454381817, 8994.370394072384, 9015.684451044215, 9058.501782401965, 9062.048484909088, 9067.727968160965, 9070.546472676373, 8992.05583413742, 9004.729858104267, 9012.188902998696, 9044.502552359618, 9044.592993315284, 8824.382293239476, 8915.955420222923, 8930.776730581787, 8948.194662480342, 8951.641934322619, 42302.94242643928, 42395.57604423978, 42490.57509424897, 42540.78729606363, 42558.36162457566, 3426.0578340956185, 3595.388783906742, 3650.0692323457347, 3783.375743002401, 4223.619874211305, 32947.6705232947, 33243.833780830944, 33438.498422523684, 33474.0, 35041.64958350409, 4276.358546218092, 4621.1219868224925, 4679.88300292492, 4690.859274221779, 4697.459792123881, 331911.3617727656, 332414.0, 333280.0, 335193.1566501203, 336247.0, 58237.0, 58612.0, 58773.706131469065, 58802.0, 58959.70520147372, 60572.39427605756, 61283.38716612866, 61295.693521533, 61399.0, 61501.0, 17472.0, 17646.117694115244, 17720.734188987175, 17724.0, 17731.822681773276, 13708.17750934947, 13712.725745485233, 13747.243901585509, 13789.586312410644, 13798.379072941741, 15138.772918406232, 16717.99692018483, 16903.830961690226, 16923.0, 17126.828731712772, 5346.973265133727, 6100.481459076028, 6452.838679033061, 6482.286948435668, 6644.60132392058, 1011.4285428732743, 1013.9910788765078, 1056.7252514346326, 1102.8456016157745, 1161.1349544589334, 32216.83891580527, 32519.349613008082, 32758.508622370682, 32781.508277375855, 33399.3320133596, 948.6632245552868, 1194.2834299420279, 1196.0, 1249.4752204074312, 1272.875091649997, 17365.392211272545, 17548.385806496968, 17564.68264880139, 17646.358286275634, 17740.11299435023, 536280.0, 539785.0, 540211.0, 540270.0, 540888.0, 58450.0, 58721.70639146777, 58797.82404351889, 58842.0, 59036.11445828316, 1232.4946771823509, 1293.3274697157426, 1341.2153889974475, 1383.598756360644, 1401.7897315402772, 30612.693873060984, 33720.662793371754, 33941.151471213416, 34297.0, 34685.826570866986, 49056.264156036974, 49501.504984949686, 49687.75156124196, 49783.751081244365, 49854.750726247585, 382948.0, 383390.0, 385754.0, 387981.0, 389432.0, 34162.65837341595, 35000.824995875875, 35271.294574108884, 35677.751278705124, 40081.1983760329, 45985.0, 47413.0, 47650.76174619105, 48473.75763121162, 48477.272840906706, 40555.0, 41604.37593436161, 41693.166136677704, 42396.364054538586, 43178.0, 40893.0, 41565.58434415738, 41830.0, 41859.58140418557, 42394.78802605967, 41101.0, 41713.58286417097, 42141.78929105335, 42689.57310426856, 42826.0, 35757.0, 36694.44958325681, 37068.814655926544, 37323.83198874072, 37857.62142378541, 27931.441371172055, 28119.156425307272, 28306.85846570754, 28566.71433285724, 28702.856485718272], "value": 20341.765690031843, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.62426385746187, 378.74434756539335, 396.8868872371374, 397.72556935714374, 404.24204616344355, 18092.819071809277, 19280.807191928077, 20574.662646927976, 20621.896890515527, 20627.381178564647, 12259.448324825382, 12262.141650084497, 15546.53360399187, 19017.809821901777, 20375.59248815023, 5290.571545682673, 5419.512243898049, 5437.265969094161, 5439.075357189267, 5462.0, 5767.394423585526, 5864.970675146618, 5931.555133364994, 5937.22816033915, 5954.255718035246, 5452.100403433429, 5833.533317334624, 5881.264841894763, 5886.940350736866, 5887.175795388649, 5652.152177173416, 5710.114932185476, 5733.569982251327, 5741.397153298906, 5743.253377060997, 5586.413426590231, 5913.083472061794, 5913.231279933624, 5914.260717410324, 5921.437463440966, 13529.526466573623, 13746.037777355588, 13884.305784710825, 13909.374078166507, 14173.14961102327, 2328.732195797471, 2344.718633763959, 2376.845505042184, 2592.2871210417097, 2747.4505098980285, 10211.591536338537, 10377.636782712645, 10404.16766658673, 10456.94771526145, 10462.633807816766, 1852.908629869834, 1858.3681548273653, 1883.4067268810281, 1897.1936926806052, 1982.4944639116932, 82139.0, 86041.56979215064, 86125.29511887081, 87239.0, 89067.55466222692, 10260.0, 10718.785624287471, 11170.385628790333, 11236.775264494665, 11268.436578171058, 15487.457938972082, 15556.844431555766, 15568.455104071303, 15621.375144994074, 15648.530544083696, 7923.9603801981775, 7938.56337901421, 8022.83954320922, 8196.0, 8229.382796290301, 7630.580318082448, 7641.732539361095, 7699.842970853614, 8066.717664881701, 8363.289120424832, 4537.795799189044, 4538.636909047268, 4550.908981820345, 4586.128635559233, 4653.744044077541, 1857.9814201857807, 1865.291189348039, 1928.7203355513373, 1942.4755316064866, 1979.158857485563, 910.4491782471641, 966.6230170233614, 969.0890562871019, 994.3437331361267, 1052.2160990062453, 19949.0, 20059.29792457257, 20093.49766255826, 20097.698534521995, 20277.0, 993.145894530703, 1009.9091081802526, 1014.6955913226003, 1024.1141412678128, 1040.490159821682, 9519.762005949906, 10998.0, 11227.775444491064, 11279.0, 11295.0, 440466.0, 451197.0, 453860.0, 457827.0, 488759.0, 89455.55272223597, 97254.0, 97618.0, 98315.50842245886, 98925.50537247267, 459.34543275831805, 463.1616773639723, 479.1758175937382, 480.46908166476237, 480.6587323000639, 10778.568857245622, 10996.450177490933, 11491.54033838637, 11777.0, 11863.0, 33924.0, 43448.0, 43536.346954795066, 45690.31464527968, 46689.76655116703, 56973.14540281816, 57443.712781435825, 59960.0, 60054.39945600488, 61119.0, 8495.575221239036, 8544.35917306217, 8815.294776417742, 9024.052474490347, 9181.816363672822, 13167.209967401986, 14271.500497482539, 14282.857171428153, 14331.460813185098, 14601.12393256408, 12410.937945310216, 12470.314132722788, 12575.754565143856, 12708.809367859674, 12802.67993300175, 11998.58004969822, 12386.81419778686, 12508.624741257778, 12523.4364453598, 12693.301868396957, 12242.326672032767, 12756.553520626734, 12864.935675321938, 12931.935340323238, 13037.087403881636, 9035.63857445721, 9158.0, 9205.447673139633, 9217.124373184537, 9303.953480232556, 12251.828242057873, 12641.988640908521, 12685.556005539762, 12754.234745915275, 12774.61676149717], "value": 8911.858232412798, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.0797379873388, 1430.2062355392757, 1444.8699617034465, 1577.928993195306, 1766.9204885780146, 8082.595870206488, 8415.957920210398, 8428.53643049632, 8669.739907802761, 8674.306055515559, 8400.537970411626, 8583.442076265039, 8588.656453741844, 8589.742307730778, 8600.784980375494, 2007.4579863436863, 2067.8242349400243, 2068.141721185714, 2274.1812947338944, 2308.226744040748, 2028.3610662641295, 2261.412032871457, 2328.3597010822073, 2333.241696448661, 2342.0, 2285.0, 2292.6904867842877, 2313.3869524576003, 2314.710661167354, 2316.930492085232, 1942.2619404626294, 2268.104098880941, 2269.4553307206315, 2275.4652656625763, 2277.9772202278014, 2159.6328624133935, 2221.389117992549, 2223.044091040852, 2225.8441909066373, 2230.743464501587, 8609.69866054685, 8647.481151130953, 8679.696210632661, 8688.435251708619, 8689.26141277992, 4978.6017118630425, 5105.259737338065, 5111.0, 5113.642045056848, 5115.104856650071, 3325.135464779175, 3410.7441941854213, 3445.672661097217, 3486.0761898097026, 3503.3693935091674, 1150.6375491720082, 1203.151777996519, 1215.7325388414536, 1216.8843959823803, 1235.1168914226282, 11932.224405413706, 11946.522139114424, 11952.70118247042, 11958.0, 11973.40132993347, 4302.096559722493, 4343.869683909487, 4497.05561832019, 4526.411566496335, 4528.298113792367, 10064.194864410829, 10071.949640251752, 10074.294799363974, 10078.647247346455, 10082.949585252027, 5052.343195384577, 5072.54347108762, 5072.822451214263, 5074.441811400743, 5075.0, 4066.0233419858664, 4450.221211288012, 4673.556012178838, 4690.742009189527, 4691.7888695008805, 3844.8654297100024, 3950.308695978192, 4028.7784171870244, 4053.61490658387, 4055.655269302142, 1222.9021678265717, 1236.097648716442, 1248.9188202766973, 1266.7339858629607, 1283.4417028592593, 877.9165979231963, 983.0611765763679, 988.367444835306, 999.6051559633904, 1007.4761124215513, 5915.319738230159, 5937.287525496881, 6046.939530604725, 6069.387107018056, 6177.227846519185, 452.3802390724662, 458.17071101306743, 460.24060300504436, 1031.9019693129142, 1054.1619412567027, 4208.452901122834, 4236.978815105905, 4264.253755592821, 4287.978560107242, 4301.548337424588, 10622.628208012682, 10666.306690065121, 10718.088962438123, 10903.182261330432, 10912.781744365067, 10704.78590428187, 10714.035736783728, 10729.0, 10729.141668666643, 10729.892701073046, 7659.310662040443, 7948.0, 7956.403269754907, 8031.55826429552, 8181.959090204511, 5859.853503662272, 6140.938590614037, 6156.230471191101, 6188.907166392598, 6209.348018458178, 9304.95347523258, 9592.856107158537, 9615.615375385187, 9904.25718071133, 10151.238657100599, 9754.75613109678, 9933.801323973335, 9985.60057597688, 10122.190224781853, 10127.64553240633, 7116.074910261633, 7338.522996005243, 7644.388448924184, 7787.805304867197, 7965.840683186188, 8570.957145214234, 8572.142785721628, 8601.268892144239, 8633.266172375168, 8639.438436501607, 7576.8484630308185, 7708.113566939649, 7731.806704832424, 7847.921520784719, 7886.526808391285, 7295.088113985752, 7450.105987281344, 7460.477766556506, 7656.770296891103, 7814.101378341564, 6763.357481039294, 6852.45180385558, 6862.862742745217, 6873.1064961554675, 6901.551399159039, 5146.485351464824, 5278.683279003272, 5320.068987927175, 5323.3878104016985, 5395.24466574672, 5098.629137451103, 5174.7930082796265, 5300.125479296027, 5354.250404943233, 5391.406945236099], "value": 4539.714922712267, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.08782075890315, 327.5316297694297, 332.466391441736, 332.9650386709397, 334.28296304427005, 5243.711595862226, 5244.79020839167, 5268.05175068488, 5273.314469119009, 5288.365396152462, 4984.675996060254, 5037.798488060474, 5197.324347834786, 5225.8954820903555, 5233.3981592116825, 4117.855875044374, 4147.776405960249, 4152.958470415288, 4154.439150714653, 4160.979195104035, 4147.543770185277, 4150.833966641346, 4162.1675664867, 4165.520965089023, 4167.812448439812, 3877.592852750463, 4032.3749818777987, 4120.484939382577, 4122.319817230154, 4144.626983571478, 4097.67218622511, 4113.6297733203855, 4113.958860411388, 4118.5263694675195, 4140.275451795938, 3683.852645894161, 3688.5798967397477, 3694.11341278094, 3695.2609478104487, 3704.481372607837, 4934.481879402683, 5067.239914012891, 5081.2632168335385, 5111.923321150149, 5143.459936706667, 4688.671792974493, 4690.859274221779, 4700.4359476862655, 4704.600108990706, 4715.528447155291, 5407.242985981966, 5413.675179489243, 5426.104692725696, 5431.592630552685, 5450.591205659592, 3901.51231096113, 4019.6132334344607, 4023.839046438139, 4035.6973227008093, 4056.574059723716, 5657.688827114507, 5660.886782264372, 5669.348024977139, 5671.574631902624, 5703.914441283343, 4096.713230073866, 4098.877033688994, 4100.938485922714, 4103.461202049231, 4114.362273847559, 3981.6217459341315, 4148.502179738391, 4153.293940030202, 4156.441334499563, 4163.6669066475215, 4655.4180727409075, 4691.366665500182, 4694.755889689235, 4701.764911754399, 4705.623550115983, 5448.665077056146, 5459.0173768721215, 5488.643238189505, 5495.527012844236, 5528.944710552843, 1322.816079608764, 1359.959201223945, 1434.6556826361598, 1443.2783608195903, 1450.8103355248595, 990.8513722941616, 1001.3841487485145, 1009.6112996496402, 1010.570507534295, 1016.8627235323285, 5180.673654979519, 5252.947470525322, 5288.550473209743, 5292.497212764782, 5305.469453054741, 5502.889942201134, 5534.308211473566, 5547.2511210986, 5550.306211723535, 5553.361363443175, 5132.358455193101, 5217.295665085241, 5250.868728281824, 5252.448492908266, 5255.76349064293, 2623.7304731407194, 2663.9600405993924, 2677.7322267773457, 2682.6646669166353, 2702.7972902032425, 5075.289459475676, 5080.542751152414, 5081.771320290596, 5103.157978933435, 5161.2516185152945, 4838.749981258731, 5014.749262536859, 5034.949650503448, 5042.268871013683, 5055.418626857885, 5060.240963855451, 5107.9489205107475, 5113.079645663742, 5128.230765385148, 5130.384353877558, 4885.509919474594, 4897.873489097598, 4899.632527560376, 4935.802567897387, 4941.703497790144, 4833.685810422311, 4878.243872199815, 4905.975470122627, 5204.739763011758, 5631.831045068655, 5837.3870743571315, 5848.152017957457, 5851.678157701367, 5852.853678657897, 5865.384134665798, 3858.9807050964564, 3922.9607703922597, 3973.8807835764974, 3981.4425980363353, 3982.2433737589763, 5562.443755624405, 5588.211772232847, 5615.719214039364, 5658.858528536654, 5665.093585026376, 5444.128939369682, 5446.700431476148, 5466.671999680032, 5521.337439507285, 5528.364238112668, 5371.382291036581, 5481.972590137024, 5501.724913754216, 5505.201745746765, 5523.226748255167, 5425.321834770653, 5440.619156658996, 5444.713220447501, 5445.346558413015, 5456.945430545803, 5403.702796346239, 5527.5577953764405, 5539.279893613804, 5543.584231182758, 5544.833654990357, 5405.891882162414, 5409.29679141709, 5415.512603865671, 5427.4301198373605, 5433.212184233343], "value": 4125.010991559577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.3063330852121, 828.0, 838.9035260944993, 841.920017598328, 843.3716880923711, 14566.49017284394, 15590.064596124226, 15606.531804045868, 15633.687326253468, 16623.251953662086, 15898.443554475596, 16196.919015404907, 16249.431269905555, 16271.755923661154, 16289.185540722947, 679.3953381490477, 821.3142026407957, 833.5582141465034, 837.426362941384, 838.5136620759945, 799.5962039170211, 824.6701319472229, 826.4710585225431, 832.0514613340796, 833.7332053742774, 867.9974629303165, 868.7524055644143, 871.8910136232971, 875.1948207648946, 876.8860048193726, 698.6122701900495, 837.2966707965338, 859.0335872143838, 863.6286396849353, 864.2999170671744, 626.4424662050778, 630.1933525087895, 630.391672036487, 631.0723236841835, 631.1258906414603, 13440.462381504729, 13454.327283635877, 13475.326233688374, 13558.661033474144, 13584.796228056586, 14991.775123373158, 15408.0, 15447.227638618024, 15476.380944762195, 15564.533064008097, 13873.0, 13991.510297139654, 14091.647708807259, 14125.364358603887, 14745.70508589833, 4625.306204069383, 4649.232876575361, 4717.575418212377, 4733.857984260478, 4839.322494850724, 62787.0, 88506.5574672129, 88650.11349886483, 90701.0, 94407.05592944051, 12213.755724885452, 12242.243087174287, 12362.320072396105, 12421.565245216554, 12722.854943054985, 23575.88212058963, 23675.7632423677, 23735.406614834767, 23880.522389552112, 23944.640830387558, 8935.0, 9045.592948317342, 9147.496887671108, 9241.537923103819, 9381.718548443558, 4951.257311403318, 4962.950370496321, 5057.620678449058, 5110.540051395392, 5152.433232344439, 3440.2431465077643, 3547.8935631930567, 3559.9288014240087, 3560.839762210707, 3562.323158599858, 584.2346526050887, 584.6993720448131, 596.0969131765379, 606.0757345048836, 608.342989571262, 537.4705914674043, 652.4584594786317, 711.9394851437582, 730.3280981497036, 741.2365263778318, 9057.304987212217, 9813.362131461432, 9829.115379615869, 9839.3112482127, 10065.849012264822, 621.4996927473427, 626.8996960486301, 645.6578013652771, 695.544418405945, 774.9612519374122, 4937.136001199776, 5001.899962000813, 5016.673916195508, 5021.949780502148, 5024.145895197825, 65997.34002660008, 84399.57800211082, 107903.46048269709, 116912.0, 117297.0, 99327.0, 99671.50164249132, 103640.48179759053, 103760.0, 105625.47187264015, 78018.0, 78488.0, 79555.60222198968, 83258.58370708108, 92431.53784231035, 9920.399842691188, 10228.028337307944, 10358.171346292429, 10617.203709721647, 10831.18766092562, 45056.77471612621, 48859.511404885496, 50795.0, 54753.45246547643, 57088.0, 80573.59713201397, 81966.0, 82030.17969820225, 82255.5887220584, 83188.58405707932, 14667.119972801665, 14997.925010374878, 15089.773653395427, 15172.914532379773, 15366.385344586091, 16103.194840257705, 16231.837681623505, 16328.67342653164, 16347.264373103, 16946.237419315912, 14396.568102956928, 14712.190829504052, 14742.894282928608, 14792.260386980823, 14937.551873443814, 13765.793513097511, 13994.790078148631, 14226.715465690835, 14453.566393008226, 14986.625334366729, 14262.0, 14288.0, 14370.712585748017, 14559.92720036393, 14571.344289506786, 11655.125865560287, 11739.47172377228, 11742.765144696887, 12069.758604827679, 12523.93738031304, 11974.521019159136, 12270.202436841577, 12280.201786883825, 12692.301923394301, 12739.29933853647], "value": 7882.1265588576325, "unit": "score"}], "name": "dromaeo_css", "value": 7226.190247711591, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 109.0, 110.0, 112.0, 109.0, 110.0, 111.0, 112.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 117.0, 170.0, 124.0, 117.0, 147.0, 117.0, 148.0, 120.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 162.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 116.0, 74.0, 75.0, 74.0, 73.0, 100.0, 74.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 116.0, 83.0, 84.0, 84.0, 120.0, 84.0, 85.0, 125.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 52.0, 52.0, 53.0, 53.0, 52.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 74.0, 74.0, 74.0, 74.0, 76.0, 74.0, 83.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 137.0, 119.0, 118.0, 118.0, 121.0, 119.0, 186.0, 120.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 162.0, 157.0, 153.0, 153.0, 153.0, 155.0, 154.0, 158.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 66.0, 62.0, 64.0, 64.0, 62.0, 62.0, 64.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1472.1999999999998, "alertThreshold": 2.0}]} 20:19:53 INFO - Return code: 0 20:19:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:19:53 INFO - # TBPL SUCCESS # 20:19:53 INFO - Running post-action listener: _resource_record_post_action 20:19:53 INFO - ##### 20:19:53 INFO - ##### Finished run-tests step (success) 20:19:53 INFO - ##### 20:19:53 INFO - Running post-run listener: _resource_record_post_run 20:19:53 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 553390080; Read time: 216; Write time: 511520 20:19:53 INFO - TinderboxPrint: CPU usage
13.0% 20:19:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 216 20:19:53 INFO - TinderboxPrint: I/O write bytes / time
553,390,080 / 511,520 20:19:53 INFO - TinderboxPrint: CPU idle
8,273.1 (86.9%) 20:19:53 INFO - TinderboxPrint: CPU user
1,197.7 (12.6%) 20:19:53 INFO - TinderboxPrint: Swap in / out
0 / 0 20:19:53 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 256598016; Read time: 192; Write time: 304264 20:19:53 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296792064; Read time: 0; Write time: 207256 20:19:53 INFO - Running post-run listener: _upload_blobber_files 20:19:53 INFO - Blob upload gear active. 20:19:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:19:53 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 20:19:53 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'] 20:19:53 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 20:19:54 INFO - (blobuploader) - INFO - Open directory for files ... 20:19:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:19:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:19:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:58 INFO - (blobuploader) - INFO - Done attempting. 20:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:59 INFO - (blobuploader) - INFO - Done attempting. 20:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:00 INFO - (blobuploader) - INFO - Done attempting. 20:20:00 INFO - (blobuploader) - INFO - Iteration through files over. 20:20:00 INFO - Return code: 0 20:20:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:20:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:20:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b4124a0bc2c3936bfc6da6aac8ae2b8c3d1ccd9bf1f4557c9becb694b06e7bcf71808ae0ed0c59162b66b55cf5c46802fbf9fda38898da1c7817b14d31672a88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f27b94a2253a233d204685aa44e07f793e9cd71f9a30f1e85a09eada8cff285ae59eb74a7b0756268a36037496960d7b2f7ef22c9407da899dc77c554ef0674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/baadf681107672a4c5bc9342501049764c07d612c4443b0a123dc59b0b744d1470a9fa09156303cef9a77291b1a735cfb17154808afa7c477cbe389e1c9d2486"} 20:20:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:20:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:20:00 INFO - Contents: 20:20:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b4124a0bc2c3936bfc6da6aac8ae2b8c3d1ccd9bf1f4557c9becb694b06e7bcf71808ae0ed0c59162b66b55cf5c46802fbf9fda38898da1c7817b14d31672a88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f27b94a2253a233d204685aa44e07f793e9cd71f9a30f1e85a09eada8cff285ae59eb74a7b0756268a36037496960d7b2f7ef22c9407da899dc77c554ef0674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/baadf681107672a4c5bc9342501049764c07d612c4443b0a123dc59b0b744d1470a9fa09156303cef9a77291b1a735cfb17154808afa7c477cbe389e1c9d2486"} 20:20:00 INFO - Running post-run listener: copy_logs_to_upload_dir 20:20:00 INFO - Copying logs to upload dir... 20:20:00 INFO - mkdir: /builds/slave/test/build/upload/logs 20:20:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.500560 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-07 20:19:59.430104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 20:19:59.433766) ========= 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=32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b4124a0bc2c3936bfc6da6aac8ae2b8c3d1ccd9bf1f4557c9becb694b06e7bcf71808ae0ed0c59162b66b55cf5c46802fbf9fda38898da1c7817b14d31672a88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f27b94a2253a233d204685aa44e07f793e9cd71f9a30f1e85a09eada8cff285ae59eb74a7b0756268a36037496960d7b2f7ef22c9407da899dc77c554ef0674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/baadf681107672a4c5bc9342501049764c07d612c4443b0a123dc59b0b744d1470a9fa09156303cef9a77291b1a735cfb17154808afa7c477cbe389e1c9d2486"} build_url:https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b4124a0bc2c3936bfc6da6aac8ae2b8c3d1ccd9bf1f4557c9becb694b06e7bcf71808ae0ed0c59162b66b55cf5c46802fbf9fda38898da1c7817b14d31672a88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f27b94a2253a233d204685aa44e07f793e9cd71f9a30f1e85a09eada8cff285ae59eb74a7b0756268a36037496960d7b2f7ef22c9407da899dc77c554ef0674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/baadf681107672a4c5bc9342501049764c07d612c4443b0a123dc59b0b744d1470a9fa09156303cef9a77291b1a735cfb17154808afa7c477cbe389e1c9d2486"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 20:19:59.459348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:19:59.459721) ========= 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=32c5991c409366f7fec8a718000001d2-1467946357.157656-1559614938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:19:59.546597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 20:19:59.547077) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 20:19:59.547565) ========= ========= Total master_lag: 0.18 =========