builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1469047727.91 results: success (0) buildid: 20160720123119 builduid: 3b318d53dfbe4ead828bc2dbbb887347 revision: b125c700ca86f4aecf1d5c5ee86d94f783abffa3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:47.911794) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:47.912230) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:47.912517) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:47.926612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:47.926882) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 13:48:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-07-20 13:48:47 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074353 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:48.018109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:48.018798) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020281 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:48.072384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 13:48:48.073285) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b125c700ca86f4aecf1d5c5ee86d94f783abffa3 --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 b125c700ca86f4aecf1d5c5ee86d94f783abffa3 --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=edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 13:48:48,091 truncating revision to first 12 chars 2016-07-20 13:48:48,091 Setting DEBUG logging. 2016-07-20 13:48:48,092 attempt 1/10 2016-07-20 13:48:48,092 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b125c700ca86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 13:48:49,263 unpacking tar archive at: autoland-b125c700ca86/testing/mozharness/ program finished with exit code 0 elapsedTime=1.550825 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 13:48:49.640164) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:49.640532) ========= script_repo_revision: b125c700ca86f4aecf1d5c5ee86d94f783abffa3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:49.641009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:49.641352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 13:48:49.651160) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-20 13:48:49.651463) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:48:49 INFO - MultiFileLogger online at 20160720 13:48:49 in /builds/slave/test 13:48:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 13:48:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:48:49 INFO - {'append_to_log': False, 13:48:49 INFO - 'base_work_dir': '/builds/slave/test', 13:48:49 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 13:48:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:48:49 INFO - 'branch': 'Autoland-Non-PGO', 13:48:49 INFO - 'buildbot_json_path': 'buildprops.json', 13:48:49 INFO - 'config_files': ('talos/linux_config.py',), 13:48:49 INFO - 'default_actions': ('clobber', 13:48:49 INFO - 'read-buildbot-config', 13:48:49 INFO - 'download-and-extract', 13:48:49 INFO - 'populate-webroot', 13:48:49 INFO - 'create-virtualenv', 13:48:49 INFO - 'install', 13:48:49 INFO - 'run-tests'), 13:48:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:48:49 INFO - 'download_minidump_stackwalk': True, 13:48:49 INFO - 'download_symbols': 'ondemand', 13:48:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:48:49 INFO - 'tooltool.py': '/tools/tooltool.py', 13:48:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:48:49 INFO - '/tools/misc-python/virtualenv.py')}, 13:48:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:48:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:48:49 INFO - 'installer_path': 'installer.exe', 13:48:49 INFO - 'log_level': 'info', 13:48:49 INFO - 'log_name': 'talos', 13:48:49 INFO - 'log_to_console': True, 13:48:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:48:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:48:49 INFO - 'opt_config_files': (), 13:48:49 INFO - 'pip_index': False, 13:48:49 INFO - 'sps_profile': False, 13:48:49 INFO - 'sps_profile_interval': 0, 13:48:49 INFO - 'suite': 'dromaeojs', 13:48:49 INFO - 'system_bits': '32', 13:48:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:48:49 INFO - 'title': 'talos-linux64-ix-033', 13:48:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:48:49 INFO - 'use_talos_json': True, 13:48:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:48:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:48:49 INFO - 'work_dir': 'build'} 13:48:49 INFO - [mozharness: 2016-07-20 20:48:49.757169Z] Running clobber step. 13:48:49 INFO - Running pre-action listener: _resource_record_pre_action 13:48:49 INFO - Running main action method: clobber 13:48:49 INFO - rmtree: /builds/slave/test/build 13:48:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:48:50 INFO - Running post-action listener: _resource_record_post_action 13:48:50 INFO - [mozharness: 2016-07-20 20:48:50.220945Z] Finished clobber step (success) 13:48:50 INFO - [mozharness: 2016-07-20 20:48:50.221045Z] Running read-buildbot-config step. 13:48:50 INFO - Running pre-action listener: _resource_record_pre_action 13:48:50 INFO - Running main action method: read_buildbot_config 13:48:50 INFO - Using buildbot properties: 13:48:50 INFO - { 13:48:50 INFO - "project": "", 13:48:50 INFO - "product": "firefox", 13:48:50 INFO - "script_repo_revision": "production", 13:48:50 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 13:48:50 INFO - "repository": "", 13:48:50 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 13:48:50 INFO - "buildid": "20160720123119", 13:48:50 INFO - "pgo_build": "False", 13:48:50 INFO - "basedir": "/builds/slave/test", 13:48:50 INFO - "buildnumber": 192, 13:48:50 INFO - "slavename": "talos-linux64-ix-033", 13:48:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:48:50 INFO - "platform": "ubuntu64_hw", 13:48:50 INFO - "scheduler": "tests-autoland-linux64-talos", 13:48:50 INFO - "branch": "autoland", 13:48:50 INFO - "repo_path": "integration/autoland", 13:48:50 INFO - "revision": "b125c700ca86f4aecf1d5c5ee86d94f783abffa3", 13:48:50 INFO - "stage_platform": "linux64", 13:48:50 INFO - "builduid": "3b318d53dfbe4ead828bc2dbbb887347", 13:48:50 INFO - "slavebuilddir": "test" 13:48:50 INFO - } 13:48:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:48:50 INFO - Running post-action listener: _resource_record_post_action 13:48:50 INFO - [mozharness: 2016-07-20 20:48:50.223492Z] Finished read-buildbot-config step (success) 13:48:50 INFO - [mozharness: 2016-07-20 20:48:50.223581Z] Running download-and-extract step. 13:48:50 INFO - Running pre-action listener: _resource_record_pre_action 13:48:50 INFO - Running main action method: download_and_extract 13:48:50 INFO - mkdir: /builds/slave/test/build/tests 13:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:48:50 INFO - https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:48:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:48:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:48:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/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 13:48:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/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 13:48:50 INFO - Downloaded 1361 bytes. 13:48:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:48:50 INFO - Using the following test package requirements: 13:48:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:48:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:48:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:48:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:50 INFO - u'jsshell-linux-x86_64.zip'], 13:48:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:48:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:48:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:48:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:48:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:48:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:48:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:48:50 INFO - https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:48:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:48:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:48:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/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 13:48:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/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 13:48:52 INFO - Downloaded 22730093 bytes. 13:48:52 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'] 13:48:52 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 13:48:53 INFO - Return code: 0 13:48:53 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 13:48: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')]} 13:48:53 INFO - https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:48:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:48:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:48:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/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 13:48:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/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 13:48:54 INFO - Downloaded 22730093 bytes. 13:48:54 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'] 13:48:54 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 13:48:56 INFO - Return code: 0 13:48: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')]} 13:48:56 INFO - https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:48:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:48:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:48:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/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 13:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/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 13:48:57 INFO - Downloaded 14403317 bytes. 13:48:57 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'] 13:48:57 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 13:48:57 INFO - Return code: 0 13:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:48:57 INFO - https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:48:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:48:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:48:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/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 13:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-z4Doz8RLmiHEncX-81pQ/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 13:48:58 INFO - Downloaded 57144217 bytes. 13:48:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:48:58 INFO - mkdir: /builds/slave/test/properties 13:48:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:48:58 INFO - Writing to file /builds/slave/test/properties/build_url 13:48:58 INFO - Contents: 13:48:58 INFO - build_url:https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:48:59 INFO - Running post-action listener: _resource_record_post_action 13:48:59 INFO - Running post-action listener: set_extra_try_arguments 13:48:59 INFO - [mozharness: 2016-07-20 20:48:59.500151Z] Finished download-and-extract step (success) 13:48:59 INFO - [mozharness: 2016-07-20 20:48:59.500469Z] Running populate-webroot step. 13:48:59 INFO - Running pre-action listener: _resource_record_pre_action 13:48:59 INFO - Running main action method: populate_webroot 13:48:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:48:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:48:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:48:59 INFO - '--tppagecycles', 13:48:59 INFO - '7'], 13:48:59 INFO - 'tests': ['tsvgm']}}, 13:48:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:48:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:48:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:48:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:48:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:59 INFO - 'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:59 INFO - 'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['damp', 'tps']}, 13:48:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:59 INFO - 'tests': ['damp', 'tps']}, 13:48:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['dromaeo_dom']}, 13:48:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:48:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['basic_compositor_video']}, 13:48:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:48:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'other-e10s': {'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['tsvgx', 13:48:59 INFO - 'tsvgr_opacity', 13:48:59 INFO - 'tart', 13:48:59 INFO - 'tscrollx', 13:48:59 INFO - 'cart']}, 13:48:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:48:59 INFO - 'tsvgr_opacity', 13:48:59 INFO - 'tart', 13:48:59 INFO - 'tscrollx', 13:48:59 INFO - 'cart']}, 13:48:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:59 INFO - 'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['tp5o']}, 13:48:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:59 INFO - 'tests': ['tp5o']}, 13:48:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:59 INFO - 'talos_options': ['--disable-e10s', 13:48:59 INFO - '--xperf_path', 13:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:59 INFO - 'tests': ['tp5n']}, 13:48:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:59 INFO - 'talos_options': ['--xperf_path', 13:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:59 INFO - 'tests': ['tp5n']}}, 13:48:59 INFO - 'talos.zip': {'path': '', 13:48:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:48:59 INFO - Running post-action listener: _resource_record_post_action 13:48:59 INFO - [mozharness: 2016-07-20 20:48:59.520505Z] Finished populate-webroot step (success) 13:48:59 INFO - [mozharness: 2016-07-20 20:48:59.520605Z] Running create-virtualenv step. 13:48:59 INFO - Running pre-action listener: _resource_record_pre_action 13:48:59 INFO - Running main action method: create_virtualenv 13:48:59 INFO - Creating virtualenv /builds/slave/test/build/venv 13:48:59 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 13:48:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:48:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:48:59 INFO - Using real prefix '/usr' 13:48:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:49:00 INFO - Installing distribute.............................................................................................................................................................................................done. 13:49:02 INFO - Installing pip.................done. 13:49:02 INFO - Return code: 0 13:49:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:02 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 0xed4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1195180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11933b0>, '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 0x11942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', '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 13:49:02 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 13:49:02 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 13:49:02 INFO - Using env: {'DISPLAY': ':0', 13:49:02 INFO - 'HOME': '/home/cltbld', 13:49:02 INFO - 'LANG': 'en_US.UTF-8', 13:49:02 INFO - 'LANGUAGE': 'en_US:en', 13:49:02 INFO - 'LOGNAME': 'cltbld', 13:49:02 INFO - 'MAIL': '/var/mail/cltbld', 13:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:02 INFO - 'MOZ_NO_REMOTE': '1', 13:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:02 INFO - 'NO_EM_RESTART': '1', 13:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:02 INFO - 'PWD': '/builds/slave/test', 13:49:02 INFO - 'SHELL': '/bin/bash', 13:49:02 INFO - 'SHLVL': '1', 13:49:02 INFO - 'TERM': 'linux', 13:49:02 INFO - 'TMOUT': '86400', 13:49:02 INFO - 'USER': 'cltbld', 13:49:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', 13:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:02 INFO - '_': '/tools/buildbot/bin/python'} 13:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:02 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 13:49:02 INFO - Cleaning up... 13:49:02 INFO - Return code: 0 13:49:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:02 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 0xed4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1195180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11933b0>, '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 0x11942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', '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 13:49:02 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 13:49:02 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 13:49:02 INFO - Using env: {'DISPLAY': ':0', 13:49:02 INFO - 'HOME': '/home/cltbld', 13:49:02 INFO - 'LANG': 'en_US.UTF-8', 13:49:02 INFO - 'LANGUAGE': 'en_US:en', 13:49:02 INFO - 'LOGNAME': 'cltbld', 13:49:02 INFO - 'MAIL': '/var/mail/cltbld', 13:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:02 INFO - 'MOZ_NO_REMOTE': '1', 13:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:02 INFO - 'NO_EM_RESTART': '1', 13:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:02 INFO - 'PWD': '/builds/slave/test', 13:49:02 INFO - 'SHELL': '/bin/bash', 13:49:02 INFO - 'SHLVL': '1', 13:49:02 INFO - 'TERM': 'linux', 13:49:02 INFO - 'TMOUT': '86400', 13:49:02 INFO - 'USER': 'cltbld', 13:49:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', 13:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:02 INFO - '_': '/tools/buildbot/bin/python'} 13:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:02 INFO - Downloading/unpacking psutil>=3.1.1 13:49:02 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 13:49:02 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 13:49:02 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 13:49:02 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 13:49:02 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 13:49:02 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 13:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:49:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:04 INFO - Installing collected packages: psutil 13:49:04 INFO - Running setup.py install for psutil 13:49:04 INFO - building 'psutil._psutil_linux' extension 13:49:04 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 13:49:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:49:04 INFO - building 'psutil._psutil_posix' extension 13:49:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:49:05 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 13:49:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:05 INFO - Successfully installed psutil 13:49:05 INFO - Cleaning up... 13:49:05 INFO - Return code: 0 13:49:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:49:05 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')]} 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:05 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')]} 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:05 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 0xed4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1195180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11933b0>, '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 0x11942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', '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 13:49:05 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 13:49:05 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 13:49:05 INFO - Using env: {'DISPLAY': ':0', 13:49:05 INFO - 'HOME': '/home/cltbld', 13:49:05 INFO - 'LANG': 'en_US.UTF-8', 13:49:05 INFO - 'LANGUAGE': 'en_US:en', 13:49:05 INFO - 'LOGNAME': 'cltbld', 13:49:05 INFO - 'MAIL': '/var/mail/cltbld', 13:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:05 INFO - 'MOZ_NO_REMOTE': '1', 13:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:05 INFO - 'NO_EM_RESTART': '1', 13:49:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:05 INFO - 'PWD': '/builds/slave/test', 13:49:05 INFO - 'SHELL': '/bin/bash', 13:49:05 INFO - 'SHLVL': '1', 13:49:05 INFO - 'TERM': 'linux', 13:49:05 INFO - 'TMOUT': '86400', 13:49:05 INFO - 'USER': 'cltbld', 13:49:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', 13:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:05 INFO - '_': '/tools/buildbot/bin/python'} 13:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:49:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:49:07 INFO - Installing collected packages: mozsystemmonitor 13:49:07 INFO - Running setup.py install for mozsystemmonitor 13:49:07 INFO - Successfully installed mozsystemmonitor 13:49:07 INFO - Cleaning up... 13:49:07 INFO - Return code: 0 13:49:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1195180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11933b0>, '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 0x11942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', '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 13:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:49:07 INFO - Using env: {'DISPLAY': ':0', 13:49:07 INFO - 'HOME': '/home/cltbld', 13:49:07 INFO - 'LANG': 'en_US.UTF-8', 13:49:07 INFO - 'LANGUAGE': 'en_US:en', 13:49:07 INFO - 'LOGNAME': 'cltbld', 13:49:07 INFO - 'MAIL': '/var/mail/cltbld', 13:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:07 INFO - 'MOZ_NO_REMOTE': '1', 13:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:07 INFO - 'NO_EM_RESTART': '1', 13:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:07 INFO - 'PWD': '/builds/slave/test', 13:49:07 INFO - 'SHELL': '/bin/bash', 13:49:07 INFO - 'SHLVL': '1', 13:49:07 INFO - 'TERM': 'linux', 13:49:07 INFO - 'TMOUT': '86400', 13:49:07 INFO - 'USER': 'cltbld', 13:49:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', 13:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:07 INFO - '_': '/tools/buildbot/bin/python'} 13:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:07 INFO - Downloading/unpacking jsonschema==2.5.1 13:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:49:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:09 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:09 INFO - warning: no files found matching '*.txt' 13:49:09 INFO - no previously-included directories found matching 'build' 13:49:09 INFO - no previously-included directories found matching 'dist' 13:49:09 INFO - no previously-included directories found matching '.git*' 13:49:09 INFO - Installing collected packages: jsonschema, functools32 13:49:09 INFO - Running setup.py install for functools32 13:49:10 INFO - warning: no files found matching '*.txt' 13:49:10 INFO - no previously-included directories found matching 'build' 13:49:10 INFO - no previously-included directories found matching 'dist' 13:49:10 INFO - no previously-included directories found matching '.git*' 13:49:10 INFO - Successfully installed jsonschema functools32 13:49:10 INFO - Cleaning up... 13:49:10 INFO - Return code: 0 13:49:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:10 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 0xed4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1195180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11933b0>, '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 0x11942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', '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 13:49:10 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 13:49:10 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 13:49:10 INFO - Using env: {'DISPLAY': ':0', 13:49:10 INFO - 'HOME': '/home/cltbld', 13:49:10 INFO - 'LANG': 'en_US.UTF-8', 13:49:10 INFO - 'LANGUAGE': 'en_US:en', 13:49:10 INFO - 'LOGNAME': 'cltbld', 13:49:10 INFO - 'MAIL': '/var/mail/cltbld', 13:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:10 INFO - 'MOZ_NO_REMOTE': '1', 13:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:10 INFO - 'NO_EM_RESTART': '1', 13:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:10 INFO - 'PWD': '/builds/slave/test', 13:49:10 INFO - 'SHELL': '/bin/bash', 13:49:10 INFO - 'SHLVL': '1', 13:49:10 INFO - 'TERM': 'linux', 13:49:10 INFO - 'TMOUT': '86400', 13:49:10 INFO - 'USER': 'cltbld', 13:49:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', 13:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:10 INFO - '_': '/tools/buildbot/bin/python'} 13:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:10 INFO - Downloading/unpacking blobuploader==1.2.4 13:49:10 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 13:49:10 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 13:49:10 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 13:49:10 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 13:49:10 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 13:49:10 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 13:49:12 INFO - Downloading blobuploader-1.2.4.tar.gz 13:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:49:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:49:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:12 INFO - Downloading docopt-0.6.1.tar.gz 13:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:49:13 INFO - Installing collected packages: blobuploader, requests, docopt 13:49:13 INFO - Running setup.py install for blobuploader 13:49:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:49:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:49:13 INFO - Running setup.py install for requests 13:49:13 INFO - Running setup.py install for docopt 13:49:13 INFO - Successfully installed blobuploader requests docopt 13:49:13 INFO - Cleaning up... 13:49:13 INFO - Return code: 0 13:49:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1195180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11933b0>, '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 0x11942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', '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 13:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:49:13 INFO - Using env: {'DISPLAY': ':0', 13:49:13 INFO - 'HOME': '/home/cltbld', 13:49:13 INFO - 'LANG': 'en_US.UTF-8', 13:49:13 INFO - 'LANGUAGE': 'en_US:en', 13:49:13 INFO - 'LOGNAME': 'cltbld', 13:49:13 INFO - 'MAIL': '/var/mail/cltbld', 13:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:13 INFO - 'MOZ_NO_REMOTE': '1', 13:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:13 INFO - 'NO_EM_RESTART': '1', 13:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:13 INFO - 'PWD': '/builds/slave/test', 13:49:13 INFO - 'SHELL': '/bin/bash', 13:49:13 INFO - 'SHLVL': '1', 13:49:13 INFO - 'TERM': 'linux', 13:49:13 INFO - 'TMOUT': '86400', 13:49:13 INFO - 'USER': 'cltbld', 13:49:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', 13:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:13 INFO - '_': '/tools/buildbot/bin/python'} 13:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:13 INFO - Running setup.py (path:/tmp/pip-icH7Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:13 INFO - Running setup.py (path:/tmp/pip-IEJNFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:13 INFO - Running setup.py (path:/tmp/pip-RQtJPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:14 INFO - Running setup.py (path:/tmp/pip-oZjNfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:14 INFO - Running setup.py (path:/tmp/pip-k0TNLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:14 INFO - Running setup.py (path:/tmp/pip-JNeA7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:14 INFO - Running setup.py (path:/tmp/pip-3xUP5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:14 INFO - Running setup.py (path:/tmp/pip-h9KkTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:14 INFO - Running setup.py (path:/tmp/pip-t_B25a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:14 INFO - Running setup.py (path:/tmp/pip-2D_Hyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:14 INFO - Running setup.py (path:/tmp/pip-MPEtlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:14 INFO - Running setup.py (path:/tmp/pip-EdU1HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:14 INFO - Running setup.py (path:/tmp/pip-4kNnxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:14 INFO - Running setup.py (path:/tmp/pip-xO8QVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:14 INFO - Running setup.py (path:/tmp/pip-Q8tVI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:14 INFO - Running setup.py (path:/tmp/pip-i5efke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:14 INFO - Running setup.py (path:/tmp/pip-Ah60Of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:49:15 INFO - Running setup.py install for manifestparser 13:49:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:49:15 INFO - Running setup.py install for mozcrash 13:49:15 INFO - Running setup.py install for mozdebug 13:49:15 INFO - Running setup.py install for mozdevice 13:49:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:49:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:49:15 INFO - Running setup.py install for mozfile 13:49:15 INFO - Running setup.py install for mozhttpd 13:49:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:49:15 INFO - Running setup.py install for mozinfo 13:49:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:49:15 INFO - Running setup.py install for mozInstall 13:49:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:49:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:49:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:49:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:49:15 INFO - Running setup.py install for mozleak 13:49:15 INFO - Running setup.py install for mozlog 13:49:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:49:16 INFO - Running setup.py install for moznetwork 13:49:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:49:16 INFO - Running setup.py install for mozprocess 13:49:16 INFO - Running setup.py install for mozprofile 13:49:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:49:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:49:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:49:16 INFO - Running setup.py install for mozrunner 13:49:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:49:16 INFO - Running setup.py install for mozscreenshot 13:49:16 INFO - Running setup.py install for moztest 13:49:16 INFO - Running setup.py install for mozversion 13:49:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:49:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:49:16 INFO - Cleaning up... 13:49:16 INFO - Return code: 0 13:49:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1195180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11933b0>, '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 0x11942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', '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 13:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:49:16 INFO - Using env: {'DISPLAY': ':0', 13:49:16 INFO - 'HOME': '/home/cltbld', 13:49:16 INFO - 'LANG': 'en_US.UTF-8', 13:49:16 INFO - 'LANGUAGE': 'en_US:en', 13:49:16 INFO - 'LOGNAME': 'cltbld', 13:49:16 INFO - 'MAIL': '/var/mail/cltbld', 13:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:16 INFO - 'MOZ_NO_REMOTE': '1', 13:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:16 INFO - 'NO_EM_RESTART': '1', 13:49:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:16 INFO - 'PWD': '/builds/slave/test', 13:49:16 INFO - 'SHELL': '/bin/bash', 13:49:16 INFO - 'SHLVL': '1', 13:49:16 INFO - 'TERM': 'linux', 13:49:16 INFO - 'TMOUT': '86400', 13:49:16 INFO - 'USER': 'cltbld', 13:49:16 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', 13:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:16 INFO - '_': '/tools/buildbot/bin/python'} 13:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:17 INFO - Running setup.py (path:/tmp/pip-pjlmVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:17 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)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:17 INFO - Running setup.py (path:/tmp/pip-2osWxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:17 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)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:17 INFO - Running setup.py (path:/tmp/pip-4lLp_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:17 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)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:17 INFO - Running setup.py (path:/tmp/pip-ACIMii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:17 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)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:17 INFO - Running setup.py (path:/tmp/pip-uI7sgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:17 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)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:17 INFO - Running setup.py (path:/tmp/pip-NRNVQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:17 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)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:17 INFO - Running setup.py (path:/tmp/pip-py1SxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:17 INFO - Running setup.py (path:/tmp/pip-W2kl5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:17 INFO - Running setup.py (path:/tmp/pip-YRUj67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:17 INFO - Running setup.py (path:/tmp/pip-O2kn7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:17 INFO - Running setup.py (path:/tmp/pip-loPDFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:17 INFO - Running setup.py (path:/tmp/pip-ZOjSfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:17 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)) 13:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:17 INFO - Running setup.py (path:/tmp/pip-7at1Ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:18 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)) 13:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:18 INFO - Running setup.py (path:/tmp/pip-6anIdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:18 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)) 13:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:18 INFO - Running setup.py (path:/tmp/pip-WBFUKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:18 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)) 13:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:18 INFO - Running setup.py (path:/tmp/pip-0e8FT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:18 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)) 13:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:18 INFO - Running setup.py (path:/tmp/pip-JZDeNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:18 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)) 13:49:18 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)) 13:49:18 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)) 13:49:18 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)) 13:49:18 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)) 13:49:18 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)) 13:49:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:49:18 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 13:49:18 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 13:49:18 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 13:49:18 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 13:49:18 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 13:49:18 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 13:49:20 INFO - Downloading blessings-1.6.tar.gz 13:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:49:20 INFO - Installing collected packages: blessings 13:49:20 INFO - Running setup.py install for blessings 13:49:20 INFO - Successfully installed blessings 13:49:20 INFO - Cleaning up... 13:49:20 INFO - Return code: 0 13:49:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:20 INFO - Reading from file tmpfile_stdout 13:49:20 INFO - Current package versions: 13:49:20 INFO - argparse == 1.2.1 13:49:20 INFO - blessings == 1.6 13:49:20 INFO - blobuploader == 1.2.4 13:49:20 INFO - docopt == 0.6.1 13:49:20 INFO - functools32 == 3.2.3-2 13:49:20 INFO - jsonschema == 2.5.1 13:49:20 INFO - manifestparser == 1.1 13:49:20 INFO - mozInstall == 1.12 13:49:20 INFO - mozcrash == 0.17 13:49:20 INFO - mozdebug == 0.1 13:49:20 INFO - mozdevice == 0.48 13:49:20 INFO - mozfile == 1.2 13:49:20 INFO - mozhttpd == 0.7 13:49:20 INFO - mozinfo == 0.9 13:49:20 INFO - mozleak == 0.1 13:49:20 INFO - mozlog == 3.3 13:49:20 INFO - moznetwork == 0.27 13:49:20 INFO - mozprocess == 0.23 13:49:20 INFO - mozprofile == 0.28 13:49:20 INFO - mozrunner == 6.12 13:49:20 INFO - mozscreenshot == 0.1 13:49:20 INFO - mozsystemmonitor == 0.3 13:49:20 INFO - moztest == 0.7 13:49:20 INFO - mozversion == 1.4 13:49:20 INFO - psutil == 3.1.1 13:49:20 INFO - requests == 1.2.3 13:49:20 INFO - wsgiref == 0.1.2 13:49:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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')]} 13:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1195180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11933b0>, '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 0x11942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', '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 13:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:49:20 INFO - Using env: {'DISPLAY': ':0', 13:49:20 INFO - 'HOME': '/home/cltbld', 13:49:20 INFO - 'LANG': 'en_US.UTF-8', 13:49:20 INFO - 'LANGUAGE': 'en_US:en', 13:49:20 INFO - 'LOGNAME': 'cltbld', 13:49:20 INFO - 'MAIL': '/var/mail/cltbld', 13:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:20 INFO - 'MOZ_NO_REMOTE': '1', 13:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:20 INFO - 'NO_EM_RESTART': '1', 13:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:20 INFO - 'PWD': '/builds/slave/test', 13:49:20 INFO - 'SHELL': '/bin/bash', 13:49:20 INFO - 'SHLVL': '1', 13:49:20 INFO - 'TERM': 'linux', 13:49:20 INFO - 'TMOUT': '86400', 13:49:20 INFO - 'USER': 'cltbld', 13:49:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', 13:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:20 INFO - '_': '/tools/buildbot/bin/python'} 13:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:49:20 INFO - Cleaning up... 13:49:20 INFO - Return code: 0 13:49:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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')]} 13:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1195180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11933b0>, '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 0x11942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', '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 13:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:49:20 INFO - Using env: {'DISPLAY': ':0', 13:49:20 INFO - 'HOME': '/home/cltbld', 13:49:20 INFO - 'LANG': 'en_US.UTF-8', 13:49:20 INFO - 'LANGUAGE': 'en_US:en', 13:49:20 INFO - 'LOGNAME': 'cltbld', 13:49:20 INFO - 'MAIL': '/var/mail/cltbld', 13:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:20 INFO - 'MOZ_NO_REMOTE': '1', 13:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:20 INFO - 'NO_EM_RESTART': '1', 13:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:20 INFO - 'PWD': '/builds/slave/test', 13:49:20 INFO - 'SHELL': '/bin/bash', 13:49:20 INFO - 'SHLVL': '1', 13:49:20 INFO - 'TERM': 'linux', 13:49:20 INFO - 'TMOUT': '86400', 13:49:20 INFO - 'USER': 'cltbld', 13:49:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', 13:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:20 INFO - '_': '/tools/buildbot/bin/python'} 13:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:49:21 INFO - Cleaning up... 13:49:21 INFO - Return code: 0 13:49:21 INFO - Running post-action listener: _resource_record_post_action 13:49:21 INFO - Running post-action listener: _start_resource_monitoring 13:49:21 INFO - Starting resource monitoring. 13:49:21 INFO - [mozharness: 2016-07-20 20:49:21.161799Z] Finished create-virtualenv step (success) 13:49:21 INFO - [mozharness: 2016-07-20 20:49:21.162276Z] Running install step. 13:49:21 INFO - Running pre-action listener: _resource_record_pre_action 13:49:21 INFO - Running main action method: install 13:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:21 INFO - Reading from file tmpfile_stdout 13:49:21 INFO - Detecting whether we're running mozinstall >=1.0... 13:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:49:21 INFO - Reading from file tmpfile_stdout 13:49:21 INFO - Output received: 13:49:21 INFO - Usage: mozinstall [options] installer 13:49:21 INFO - Options: 13:49:21 INFO - -h, --help show this help message and exit 13:49:21 INFO - -d DEST, --destination=DEST 13:49:21 INFO - Directory to install application into. [default: 13:49:21 INFO - "/builds/slave/test"] 13:49:21 INFO - --app=APP Application being installed. [default: firefox] 13:49:21 INFO - mkdir: /builds/slave/test/build/application 13:49:21 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'] 13:49:21 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 13:49:37 INFO - Reading from file tmpfile_stdout 13:49:37 INFO - Output received: 13:49:37 INFO - /builds/slave/test/build/application/firefox/firefox 13:49:37 INFO - Running post-action listener: _resource_record_post_action 13:49:37 INFO - [mozharness: 2016-07-20 20:49:37.847530Z] Finished install step (success) 13:49:37 INFO - [mozharness: 2016-07-20 20:49:37.847868Z] Running run-tests step. 13:49:37 INFO - Running pre-action listener: _resource_record_pre_action 13:49:37 INFO - Running main action method: run_tests 13:49:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:49:37 INFO - Python 2.7.3 13:49:37 INFO - Return code: 0 13:49:37 INFO - grabbing minidump binary from tooltool 13:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11933b0>, '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 0x11942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:49:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:49:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:49:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:49:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:49:37 INFO - Return code: 0 13:49:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:49:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:49:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:49:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:49:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:49:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 13:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 13:49:37 INFO - Using env: {'DISPLAY': ':0', 13:49:37 INFO - 'HOME': '/home/cltbld', 13:49:37 INFO - 'LANG': 'en_US.UTF-8', 13:49:37 INFO - 'LANGUAGE': 'en_US:en', 13:49:37 INFO - 'LOGNAME': 'cltbld', 13:49:37 INFO - 'MAIL': '/var/mail/cltbld', 13:49:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:49:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:37 INFO - 'MOZ_NO_REMOTE': '1', 13:49:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:37 INFO - 'NO_EM_RESTART': '1', 13:49:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:37 INFO - 'PWD': '/builds/slave/test', 13:49:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:49:37 INFO - 'SHELL': '/bin/bash', 13:49:37 INFO - 'SHLVL': '1', 13:49:37 INFO - 'TERM': 'linux', 13:49:37 INFO - 'TMOUT': '86400', 13:49:37 INFO - 'USER': 'cltbld', 13:49:37 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095', 13:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:37 INFO - '_': '/tools/buildbot/bin/python'} 13:49:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 13:49:38 INFO - mozversion application_buildid: 20160720123119 13:49:38 INFO - mozversion application_changeset: b125c700ca86f4aecf1d5c5ee86d94f783abffa3 13:49:38 INFO - mozversion application_display_name: Nightly 13:49:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:49:38 INFO - mozversion application_name: Firefox 13:49:38 INFO - mozversion application_remotingname: firefox 13:49:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:49:38 INFO - mozversion application_vendor: Mozilla 13:49:38 INFO - mozversion application_version: 50.0a1 13:49:38 INFO - mozversion platform_buildid: 20160720123119 13:49:38 INFO - mozversion platform_changeset: b125c700ca86f4aecf1d5c5ee86d94f783abffa3 13:49:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:49:38 INFO - mozversion platform_version: 50.0a1 13:49:38 INFO - using testdate: 1469047778 13:49:38 INFO - actual date: 1469047778 13:49:38 INFO - starting webserver on 'localhost:52572' 13:49:38 INFO - SUITE-START | Running 2 tests 13:49:38 INFO - TEST-START | dromaeo_css 13:49:38 INFO - operating with platform_type : linux_ 13:49:38 INFO - Initialising browser for dromaeo_css test... 13:49:38 INFO - TEST-INFO | started process 31997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Jjkm7/profile http://localhost:52572/getInfo.html) 13:49:43 INFO - PROCESS | 31997 | __metrics Screen width/height:1600/1200 13:49:43 INFO - PROCESS | 31997 | colorDepth:24 13:49:43 INFO - PROCESS | 31997 | Browser inner width/height: 1024/697 13:49:43 INFO - PROCESS | 31997 | __metrics 13:49:44 INFO - PROCESS | 31997 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:49:44 INFO - PROCESS | 31997 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:49:45 INFO - TEST-INFO | 31997: exit 0 13:49:45 INFO - Browser initialized. 13:49:45 INFO - Running cycle 1/1 for dromaeo_css test... 13:49:45 INFO - TEST-INFO | started process 32079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Jjkm7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:49:57 INFO - PROCESS | 32079 | RSS: Main: 159150080 13:49:57 INFO - PROCESS | 32079 | 13:50:49 INFO - PROCESS | 32079 | 1469047849819 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] 13:53:01 INFO - PROCESS | 32079 | Cycle 1(1): loaded http://localhost:52572/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52572/tests/dromaeo/cssquery-ext.html) 13:53:02 INFO - PROCESS | 32079 | RSS: Main: 247808000 13:53:02 INFO - PROCESS | 32079 | 13:56:05 INFO - PROCESS | 32079 | Cycle 1(1): loaded http://localhost:52572/tests/dromaeo/cssquery-ext.html (next: http://localhost:52572/tests/dromaeo/cssquery-jquery.html) 13:56:06 INFO - PROCESS | 32079 | RSS: Main: 244928512 13:56:06 INFO - PROCESS | 32079 | 13:59:08 INFO - PROCESS | 32079 | Cycle 1(1): loaded http://localhost:52572/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52572/tests/dromaeo/cssquery-mootools.html) 13:59:09 INFO - PROCESS | 32079 | RSS: Main: 188932096 13:59:09 INFO - PROCESS | 32079 | 14:02:11 INFO - PROCESS | 32079 | Cycle 1(1): loaded http://localhost:52572/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52572/tests/dromaeo/cssquery-prototype.html) 14:02:12 INFO - PROCESS | 32079 | RSS: Main: 189108224 14:02:12 INFO - PROCESS | 32079 | 14:05:15 INFO - PROCESS | 32079 | Cycle 1(1): loaded http://localhost:52572/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52572/tests/dromaeo/cssquery-yui.html) 14:05:15 INFO - PROCESS | 32079 | RSS: Main: 190464000 14:05:15 INFO - PROCESS | 32079 | 14:08:18 INFO - PROCESS | 32079 | Cycle 1(1): loaded http://localhost:52572/tests/dromaeo/cssquery-yui.html (next: http://localhost:52572/tests/dromaeo/cssquery-dojo.html) 14:08:18 INFO - PROCESS | 32079 | RSS: Main: 280850432 14:08:18 INFO - PROCESS | 32079 | 14:08:18 INFO - PROCESS | 32079 | __start_tp_report 14:08:18 INFO - PROCESS | 32079 | _x_x_mozilla_page_load 14:08:18 INFO - PROCESS | 32079 | _x_x_mozilla_page_load_details 14:08:18 INFO - PROCESS | 32079 | |i|pagename|runs| 14:08:18 INFO - PROCESS | 32079 | |0;dojo.html;2586.4051268208314;2593.1701855406277;2623.0425894548484;2638.4986852498014;2645.6296118543405;4594.150082234781;4646;4676.1349150407195;4699.154152252593;4704.929426058603;4649.3490911272365;4685.531446855312;4725.031368569444;4732.408448943882;4756.191447453933;4276.743395396271;4285.721428107178;4356.150550642626;4415.73505589664;4497.10057988402;4415.779211039451;4448.332750087497;4456.108778244364;4465.955340446602;4471.441069866267;4236.957630423718;4285.185814695229;4289.978550107261;4317.719348242385;4347.847825326098;4335.609795118455;4338.8047537860875;4373.081652852905;4385.101054283864;4390.78046097697;4365.519792822787;4382.452193475816;4398.692091553593;4418.248897687401;4421.248387774086;4624.121416930806;4778.593819525345;4827.25177597473;4841.515848415165;4844.612431005511;5032.119379108678;5075.822346217865;5081.085404627165;5152.072626927152;5158.92261616076;5128.102582048164;5145.536901678867;5171.3277273954145;5175.327207463043;5176.430592634845;4618.122556714214;4757.09615173116;4777.283407488835;4823.589994850407;4823.782929768169;5178.223266510054;5211.478852114758;5227.424983251839;5300.390455097636;5334.626576139711;5033.345665063592;5045.8738531537;5085.084684756779;5089.033083714083;5089.872753181126;4887.706737595756;5138.3577052868395;5148.4079330876675;5148.613853960968;5160.767765450564;4740.1230772307235;4924.162892308244;4949.703017818871;4999.625028122905;5040.823571174991;4951.826686066042;4959.578435832995;4965.875853103701;4970.179920313108;5022.573081288131;4228.640565551901;4325.870223893288;4335.544767799399;4339.262325404688;4386.780660966939;3669.7247706422127;3738.719596030309;3774.8112594370173;3793.1844653399653;3874.9612503875164;4393.143337049309;4417.646588272931;4418.226810308183;4423;4465.285554311295;5121.514760719424;5126.564242039469;5126.615503837227;5128.743562821918;5174.818881339135;4315.503717072514;4351.891202719894;4363.105563359503;4387.451568553931;4444.1333939881415;4626.352310676508;4626.537346265347;4633.72197668141;4649.116667833101;4684.8360307389075;4758.571728544448;4776.116418462596;4794.137055330074;4802.567768900815;4847.079054979543;4828.758562071953;5037.924431133462;5066.746662666778;5072.137736584863;5156.819511317086;4757.9048419032115;4793.664443489062;4796.472388037243;4802.51974802517;4861.902761944671;5006.07387633289;5014.42334131565;5031.647784655185;5032.773525191302;5083.313752643346;4937.136001199704;4941.085899108676;4960.206366981266;4983.327250821093;5030.547250747304;4849.927251091166;4851.417829860439;4855.028994201244;4863.927041094315;4903.7302948336755;4833.347498087714;4854.029194161111;4866.294387313749;4870.366852309177;4923.606111510999;4777.8327758528285;4795.160846851857;4797.856064318076;4803.711777293373;4906.681065730716;4891.26631005352;4903.882902423695;4909.509049095205;4913.238448040559;4965.900681986268;4849.75751212445;4862.756862156807;4864.805407783649;4865.391826021747;4908.4355299139625 14:08:18 INFO - PROCESS | 32079 | |1;ext.html;573.4323020209993;575.6431012772082;583.8277708076117;600.327633050983;602.2983224543407;27523.449531009366;39750;40851.38722919158;40883;44778.32832507507;42271;42554.574454255446;42734.35898461525;42758.786206069;42761.786191069004;7542.736004239852;7843.411744119199;7982.600869956508;8002;8005.279524842763;9939.453330066843;10204.132648724868;10218.48907554623;10583.682489525327;10594.894051059468;10376.636817711382;10458.581656733722;10466.790664186712;10479.633212837552;10484.947575262113;7562.205968373351;9995.650152244709;10263.332883362595;10318.277720559563;10321.84517232242;9879.456629885353;9952.950235248778;9959.452230127341;9964.70105896817;9979.251556133318;39218.60781392206;39576.80211598952;39577.60422395797;39592.60407395918;39609.40585891214;3051.67957364478;3249.96750032499;3576.5708115026105;3664.047347689593;3902.4926759521363;29858.85070574655;29881.850590747126;30071.849640751876;30107.0967870962;31382.215444613837;3506.596741374749;3541.4333706606817;3548.6273941236313;3626.3110009098186;3656.561212654472;258713;259541;261210;261279;261751;32350.35299294001;55181;55624.16563751547;55806;55828;32573.674263257537;34388;34495.13762155916;34505.65494345075;34565.82717086399;13080.738385232242;13160.276184809927;13164.210147390995;13175.736485270241;13179.868201318055;9025.729228123168;10895.673129806119;11039.83440248397;11101.389423581619;11171.66485005451;7900.920990790133;7913.366930645535;7976.561289129154;7980.321672657889;8038.718644847402;3150.5116706910467;3150.684931506831;3150.9054728358187;3157.2422618571836;3181.1887968567867;889.7241855024963;917.495377542349;947.3889341374775;1006.0643601450721;1038.6987773545738;27874.860625697147;29350;29498;29786.851065744966;29787.702122978928;974.8099120671543;976.7069879036261;981.47000619666;1029.156092004549;1049.8477720730605;14909.776353354708;15791.447299344467;15822.446214382671;16239.756403653955;16389.180540972902;417415;423593;423712;426285;426699;52395.73802130965;52773.472265277625;52838.94322113536;52839.207411888856;52882.206766898526;1083.864516935383;1120.8991190792867;1137.3858116616934;1199.8860108289698;1213.5267245774155;23166.536669266858;29454.558181626864;29644.851775740983;32052.83973580117;32237;47861;48554.75722621506;48556;48582;48627.51372486371;359071;361496;362830;362923;363297;22142;22517.32448026562;23152;25756.484870302866;26146.738532615193;38668;41140;42354.78822605867;42430.36354454624;42469;36383;36737.26525469529;37102.44346334861;37714.811425942695;39528;37381.813090934374;37598.43602345912;40086.198276033734;41179.7941010293;41438.79280603577;39345.40981885217;39817.40273895836;40127.39808902927;40145;40174;38210.2357952845;39093.41359879661;39940.807694999465;40133.397999030625;40544;23182.420439488473;23924.404108906372;24615.38461538476;24743;24842.875785620956 14:08:18 INFO - PROCESS | 32079 | |2;jquery.html;362.2646028562019;364.08977556109744;370.2225326813691;378.7765218521072;381.81100355324116;16661.83338166618;17427.738583921237;17803.198856051462;17933.103344832773;17936.551586210353;16529.586760330996;17139;17504.737428938544;17617.383391581297;17626.294948202056;4939.77771000305;5184.7407629618365;5186.196139598368;5188.922166167492;5189.299444574972;3812.6377994090517;3994.4807175067344;5106.5659418949435;5692.943070569283;5946.910796338037;6046.304674962392;6047.15339852421;6055.061465472859;6061.424164704368;6061.969690151543;5759.560109972507;5916.615419997708;5933.406659334075;5940.97029514854;5943.851403714899;3426.468897320919;3603.1532589841368;3605.3330133925047;5232.241325007891;5240.3973543042275;19498.317558885512;20146.39560813178;20832.687509687366;21791.891040544855;22020.88989555058;1888.8111188881003;2109.440998135495;2123.278085450954;2284.851484653509;2396.113438027941;12922.935385323108;13419;13743.587692369245;13912.165270083828;14137.363818628186;1720.3894507987568;1720.4064597713768;1721.5320346685025;1737.0880287848854;1773.3172728499621;68210.3178968209;69033.65483172602;69682.30317696859;69823.65088174578;70515.99999999949;9441.103095205945;9679.096271118777;9704.9029509704;9933.991761377765;10637.414942178255;13426.127301725357;13453.730925381633;13468.461261549428;13483.460661573623;13496.190228586316;7198.820029499199;7499;7560.470767046254;7585.924140758521;7672.923270767333;7339.192688804227;7343.926560734324;7546.547207167588;7557.697692092364;7571.772846814604;6142.78500252498;6260.530460215502;6273.52948528853;6275.623462592259;6300.117983482316;1649.909254990987;1688.4174959638906;1755.2013833705632;1796.6765982123343;1825.917833697487;840.9663613455516;906.0857097339431;910.9180173784391;922.5986695787354;933.6078846884325;17492.912535437496;17691.38080167188;18360.357387491375;18534.351297704787;18535.258589656263;810.9513429194267;853.1383302864028;875.3391189651772;876.5354362188051;898.81574277273;7987.920120798718;9546.140847323773;9727.708168754949;9759.804803903882;9943.303968722264;399744;402437;407556;411611;429764;85049;86735.56632216799;87198.56400717956;87334;88557.55721221482;833.3832963606887;898.9370744047985;921.9308551858637;952.3666761603595;955.5126885288414;15264.465743698916;15753.767474590353;16278.755818662492;16919.91540042292;16966.745498817774;37602.62397375991;38329;38601.6139838598;38679.6132038676;39425.40861887131;49905.50094499008;50404;53545;53996;54394.18408723951;7702.383809295131;7866.449348545547;7984.880226796487;7986.081600616004;8004.319632831274;11738.94130529342;12081.214721043105;12358.505659773868;12393.938030310152;13151.934240328737;9972.50137493137;10391.532381043022;10396.844047339448;10461.947690261804;11327.376994265065;10577.259591828499;10639.521221544894;10682.465876706288;10882.183836212474;11040.834387484354;10724.624638137628;11055.834162487408;11139.888601113886;11272.887271127183;11376.658700239006;7912.881306780518;7961.124276329483;7979.640916158903;8168.305694016075;8336.374771892253;10231.693049208536;10748.301360411548;10947.890521095005;10993.450327483433;11160.944195278971 14:08:18 INFO - PROCESS | 32079 | |3;mootools.html;1386.4939297156538;1418.7233489469552;1498.2059508460513;1678.2364024368912;1725.7066298729223;7502.249775022502;8076.757697269077;8077.717279895205;8084.919150808505;8087.8786818197705;6799.252082270958;7441.888371674429;7659.961700191505;7726.575038372887;7894.881576776353;2181.094845639058;2207.3708992937018;2208.326460429568;2208.4147700859285;2208.7901649343366;2201.504661451169;2217.6784366266884;2247.1011595361824;2247.6179049561533;2249.9437514062197;1903.2101677803694;2136.6154092263387;2202.5044365017825;2203.3059586230365;2226.9888650556804;2203.7575866654734;2207.128184367166;2226.476777957179;2229.320057382498;2231.5871563760757;2209.127394679109;2215.8116560092412;2217.700610417589;2220.012094617896;2222.0445208560313;7945.602719864041;7994.960025199837;7995.960020199862;7996.68013279474;7998.960005199937;4534.569215924482;4587.42657167854;4676.789544470507;4681.74250416227;4681.953180468186;2740.945181096367;2916.8104073235386;2922.167182353019;2926.356201635637;2927.443785680714;913.7761248494095;939.9812003759955;955.2644463762933;978.6770365779275;979.3829887171108;10470.895291047143;10529.84205236922;10570.101541368993;10607.310524815863;10650.25448218625;3887.6501114899793;4050.210209009215;4191.895202619898;4209;4224.619784219435;9153.35926485153;9186.448813071103;9194.31042671789;9194.586243619053;9203;4645.140648979882;4649.209634362167;4650.86047418578;4650.9767451162525;4653.906921861611;4172.833086676499;4241.915161696748;4242.087951090469;4242.257604919127;4243.342281946303;3611.476335931328;3613.2954073955852;3660.890173294805;3755.586885442599;3756.7933763643264;1145.7651181507772;1167.8656954450346;1182.0720734223594;1185.4783895086134;1188.085174415695;659.9406053455212;667.1793693756609;697.4838619421591;738.7968308715147;748.6518768772547;5074.416442109131;5097.668651537638;5169.870753231124;5183.948160518346;5231.424543300234;810.9837803243902;831.7047448155938;883.6332921837494;889.1775108025051;890.670451932789;3380.7464440167087;3502.2295095079044;3530.1704099536587;3541.6812486876306;3586.9282614347567;9188.816223675489;9513.04869513057;9625.422474651403;9648.469334186546;9649.083337082966;9574.664886728931;9576.808463830825;9581.664641737645;9587.472689002032;9600.807983840285;6008.609440386361;6271.43557079865;7085.964570177116;7188.928110718931;7350.852982940204;5209.791608335624;5351.2508248844415;5390.19147127934;5468.371137319259;5617.8033768817895;8653.870191947251;8730.388872779098;8807;8843.585026396004;8853.15894989975;8802.867956980523;8903.421277616933;8994.505302208441;9049.366544341832;9054.049324820799;6764.086848275617;6799.082123913208;6866.416354609914;6870.072540207008;6871.415929646036;7439.144498382755;7485.663145158372;7501.474896757175;7503.1746507883;7509.324160825552;6451.0645956337;6667.299933506912;6706.83232919181;6824.07874936897;6827.93172068273;6558.540902136805;6687.966560167168;6708.966455167693;6744.359285867835;6754.763583274562;6278.6546739929745;6302.842428939313;6349;6360.045993101072;6452.677366131768;4320.978395108004;4499.077689073667;4521.9547804521535;4579.816807327803;4755.857324280277;4512.616427603691;4546.704464209815;4604.769761511844;4631.745254011062;4655.162070827284 14:08:18 INFO - PROCESS | 32079 | |4;prototype.html;299.9940001199976;302.30771533188994;305.7752551874373;306.6197914585914;309.0804855554725;4804.543568361005;4828.537445902593;4851.417829860417;4854.3689320388385;4873.439554451239;4815.590674792638;4822.4454187768415;4848.7575621218975;4849.418069831625;4858.222684370501;3648.9635103648957;3696.3900956342172;3725.2921944830396;3743.232637309359;3764.171882185915;3766.6986641068784;3788.7916164610933;3800.5937803012926;3806.4100064489908;3811.4473401356927;3755.324041672498;3758.154415256559;3761.6990640748813;3774.622537746217;3774.641409066148;3613.0606042429026;3655.524781778365;3768.9246215075545;3784.9053773655605;3787.3750831112834;3359.4792807114936;3359.882404115844;3367.1582104473882;3374.6794054564775;3379.3410284994434;4720.221163508051;4727.834525791581;4730.337752714623;4736.857894263143;4738.312944623045;4218.704690671623;4354.194474022316;4367.126574685076;4371.562843715635;4378.277584198603;4957.727324997124;5008.247113510279;5012.273220383024;5023.171176755831;5029.497050294978;3698.33429982603;3711.0165806061414;3714.052916506301;3715.294094122135;3720.5163328767358;5065.138926382524;5259.605529585297;5303.124984377573;5312.184542192644;5344.385395679469;3748.231612519427;3759.680427163667;3761.6990640748672;3771.2080463102507;3776.169242766587;3798.601146879593;3803.2773772983046;3809.466674665549;3813.122981714221;3831.4061320495366;4332.67504937131;4341.848035318749;4346.847860324937;4351.19502891966;4353.673474489426;4837.806487740521;4991.9500804991485;4997.625178111583;5047.621428392885;5084.51697088776;1281.858995510493;1295.7149427126017;1296.5202874936333;1298.2210673595766;1298.69480672042;835.415209353455;838.9244967952914;847.9915200848036;853.7780177153985;870.573419024686;4421.668374871833;4437.134758722018;4440.977795111068;4462.196804575207;4466.508684044752;5116.539511443988;5136.152534831711;5144.151215049475;5146.408163061295;5152.3044389007755;4348.369486424514;4429.313456414261;4433.672322030895;4437.112577484451;4438.7114837535455;2714.9457010859674;2736.2475319287355;2742.6023226632424;2747.3406382468065;2755.3800394911386;4874.4150701916;4879.243717223836;4881.438634557;4889.853304400874;4927.310176575283;5063.822766203239;5267.367915850046;5278.498542638443;5294;5303.920441193385;4820.204666230103;4846.830360937351;4872.244802055616;4882.8281212509455;4882.950165714388;5091.821786237612;5103.362079740033;5113.616478764033;5125.718085505333;5127.512886275797;4736.73947932867;4998.400191976986;4998.400191976986;5023.748812559431;5113.7698803553185;4927.063857866994;4930.630202734737;4940.382452193476;4944.307796908363;4953.479884612208;3682.944755828611;3728.944065839069;3745.2509498099944;3754.4368344748505;3761.830717617659;5099.184130539096;5307.389650190123;5308.708021058879;5317.1492561190025;5327.680339179662;5013.799448022039;5080.415752188545;5096.923546146885;5141.897162056813;5165.431802501646;5024.648274620741;5067.569256613082;5069.518395752398;5112.71880046601;5117.8976420470635;4769.499202583679;4993.526909561615;5011.624128190328;5023.372078490189;5024.924626130538;4769.666123371469;4843.539863712942;5000.724960127228;5019.3976722793495;5039.924401134059;4955.479674634112;4956.231784073474;4957.504249575014;4967.4535801062575;4979.178435558092 14:08:18 INFO - PROCESS | 32079 | |5;yui.html;628.8710814283072;638.3903372279474;665.3246954341341;768.5888049893308;778.2062296457611;13171.868281317184;14393.928030359833;14417.855821441783;14473.927630361846;14479.927600361983;12607.117501774857;12938.288394138342;12965.481380744783;13711.177329360245;13848.653783655414;625.5027253333611;753.8040109571524;790.7232468635989;808.4462143431739;809.5911564659868;794.4081659163902;808.5795386399069;808.745245247748;809.3565615335792;809.3889113719164;853.9146085391442;855.0679759062621;855.529458797662;855.6748435594496;855.9614817333235;642.9967850160766;782.2334112569657;843.5107637570195;843.6372359885247;843.641452382741;601.9307779605314;602.8462742000805;602.9577929544934;603.3031848215319;603.8399824046631;14013.719725605431;14032.43870245189;14051.929740351336;14055.016148869583;14066.156030638194;12591.937040314831;12708.364581770875;12845.614631561068;13037.41331640069;13357.198568085945;10760.258341661356;11015.118790496741;11024.614138505114;11236.325820450798;11291.20961532693;4161.633635066672;4182.100848317596;4218.11419601884;4227;4296.613304802583;67536.32463675349;67598.66200669014;67730;67806;67871.32128678699;9812.705618831447;9885.50572471388;10025.448600327052;10071.697849064392;10390.584376625002;18285.725714114298;18403.17185726619;18419.81580184181;18437.81562184361;18484.537886552946;6996;7018;7070.186928503185;7178.605176715227;7181.281871812881;3694.9815250923575;3702.4631428442726;3706;3738.700903927679;3813.6056721790733;2765.2395591212176;2856.200263926104;2861.642294713161;2882.0489238551645;2890.956635650467;483.7605385334212;488.47976904597203;497.5913407212098;499.8725325042164;504.2285303485673;496.83604410544433;510.4002796713846;511.94880511949253;518.2821791818359;547.460751160107;7433.591152486665;7546.735864244725;7665.501742386727;7801.375889928792;8216.794580135544;510.75483767791667;517.834293026228;529.9973500132475;531.3915566676134;532.0990218477108;3623.7644553103964;3681.4845921571;3785.5835858055593;3800.144967382372;3812.066043819282;60298.39701602928;60663;62568;63008.68495657492;63196;89901.55049224843;90774;95625.52187239019;96578;97427;61358.38641613527;82880.58559707283;83094;84691;85195;7945.1260361359045;8251.546164960984;8467.15328467173;8501.319894408556;8560.529170895661;31125.221869453446;32535;40999.1800164001;41262.58737412588;42492.57507424886;56220.437795623155;60159.86243232749;60779;63394.36605633885;64278.67860660667;9896.20830333586;10378.481075946022;10662;11058.281211721212;11389.544418223179;11681.532738690697;12054.859609093155;12115.515379384726;12787.232766034067;12855.678608034874;11574.942125289657;11928.701782455508;12091.637250882488;12099.33453660057;12275.140740148105;11996.340201289013;12507.93746031264;12735.490580377053;12755.681107972376;12997.415116319598;10897.291676041032;11456.255343402652;11499.942500287445;11856.881431185579;12344.321062341658;9899.20806335477;10110.496689070564;10445.373277603368;10518.684439466828;10773.138148948223;8885.733427997171;9865.161461275871;9923.305368624127;10035.19718422539;10106.797864042825 14:08:18 INFO - PROCESS | 32079 | __end_tp_report 14:08:18 INFO - PROCESS | 32079 | __start_cc_report 14:08:18 INFO - PROCESS | 32079 | _x_x_mozilla_cycle_collect,975 14:08:18 INFO - PROCESS | 32079 | __end_cc_report 14:08:18 INFO - PROCESS | 32079 | __startTimestamp1469048898822__endTimestamp 14:08:18 INFO - PROCESS | 32079 | 14:08:18 INFO - PROCESS | 32079 | ------- Summary: start ------- 14:08:18 INFO - PROCESS | 32079 | Number of tests: 6 14:08:18 INFO - PROCESS | 32079 | 14:08:18 INFO - PROCESS | 32079 | [#0] dojo.html Cycles:165 Average:4685.79 Median:4803.71 stddev:491.01 (10.2%) stddev-sans-first:464.08 14:08:18 INFO - PROCESS | 32079 | Values: 2586.4 2593.2 2623.0 2638.5 2645.6 4594.2 4646.0 4676.1 4699.2 4704.9 4649.3 4685.5 4725.0 4732.4 4756.2 4276.7 4285.7 4356.2 4415.7 4497.1 4415.8 4448.3 4456.1 4466.0 4471.4 4237.0 4285.2 4290.0 4317.7 4347.8 4335.6 4338.8 4373.1 4385.1 4390.8 4365.5 4382.5 4398.7 4418.2 4421.2 4624.1 4778.6 4827.3 4841.5 4844.6 5032.1 5075.8 5081.1 5152.1 5158.9 5128.1 5145.5 5171.3 5175.3 5176.4 4618.1 4757.1 4777.3 4823.6 4823.8 5178.2 5211.5 5227.4 5300.4 5334.6 5033.3 5045.9 5085.1 5089.0 5089.9 4887.7 5138.4 5148.4 5148.6 5160.8 4740.1 4924.2 4949.7 4999.6 5040.8 4951.8 4959.6 4965.9 4970.2 5022.6 4228.6 4325.9 4335.5 4339.3 4386.8 3669.7 3738.7 3774.8 3793.2 3875.0 4393.1 4417.6 4418.2 4423.0 4465.3 5121.5 5126.6 5126.6 5128.7 5174.8 4315.5 4351.9 4363.1 4387.5 4444.1 4626.4 4626.5 4633.7 4649.1 4684.8 4758.6 4776.1 4794.1 4802.6 4847.1 4828.8 5037.9 5066.7 5072.1 5156.8 4757.9 4793.7 4796.5 4802.5 4861.9 5006.1 5014.4 5031.6 5032.8 5083.3 4937.1 4941.1 4960.2 4983.3 5030.5 4849.9 4851.4 4855.0 4863.9 4903.7 4833.3 4854.0 4866.3 4870.4 4923.6 4777.8 4795.2 4797.9 4803.7 4906.7 4891.3 4903.9 4909.5 4913.2 4965.9 4849.8 4862.8 4864.8 4865.4 4908.4 14:08:18 INFO - PROCESS | 32079 | 14:08:18 INFO - PROCESS | 32079 | [#1] ext.html Cycles:180 Average:49940.90 Median:3660.30 stddev:93820.67 (2563.2%) stddev-sans-first:94010.65 14:08:18 INFO - PROCESS | 32079 | Values: 573.4 575.6 583.8 600.3 602.3 27523.4 39750.0 40851.4 40883.0 44778.3 42271.0 42554.6 42734.4 42758.8 42761.8 7542.7 7843.4 7982.6 8002.0 8005.3 9939.5 10204.1 10218.5 10583.7 10594.9 10376.6 10458.6 10466.8 10479.6 10484.9 7562.2 9995.7 10263.3 10318.3 10321.8 9879.5 9953.0 9959.5 9964.7 9979.3 39218.6 39576.8 39577.6 39592.6 39609.4 3051.7 3250.0 3576.6 3664.0 3902.5 29858.9 29881.9 30071.8 30107.1 31382.2 3506.6 3541.4 3548.6 3626.3 3656.6 258713.0 259541.0 261210.0 261279.0 261751.0 32350.4 55181.0 55624.2 55806.0 55828.0 32573.7 34388.0 34495.1 34505.7 34565.8 13080.7 13160.3 13164.2 13175.7 13179.9 9025.7 10895.7 11039.8 11101.4 11171.7 7900.9 7913.4 7976.6 7980.3 8038.7 3150.5 3150.7 3150.9 3157.2 3181.2 889.7 917.5 947.4 1006.1 1038.7 27874.9 29350.0 29498.0 29786.9 29787.7 974.8 976.7 981.5 1029.2 1049.8 14909.8 15791.4 15822.4 16239.8 16389.2 417415.0 423593.0 423712.0 426285.0 426699.0 52395.7 52773.5 52838.9 52839.2 52882.2 1083.9 1120.9 1137.4 1199.9 1213.5 23166.5 29454.6 29644.9 32052.8 32237.0 47861.0 48554.8 48556.0 48582.0 48627.5 359071.0 361496.0 362830.0 362923.0 363297.0 22142.0 22517.3 23152.0 25756.5 26146.7 38668.0 41140.0 42354.8 42430.4 42469.0 36383.0 36737.3 37102.4 37714.8 39528.0 37381.8 37598.4 40086.2 41179.8 41438.8 39345.4 39817.4 40127.4 40145.0 40174.0 38210.2 39093.4 39940.8 40133.4 40544.0 23182.4 23924.4 24615.4 24743.0 24842.9 14:08:18 INFO - PROCESS | 32079 | 14:08:18 INFO - PROCESS | 32079 | [#2] jquery.html Cycles:180 Average:25603.13 Median:401090.50 stddev:67820.91 (16.9%) stddev-sans-first:67984.69 14:08:18 INFO - PROCESS | 32079 | Values: 362.3 364.1 370.2 378.8 381.8 16661.8 17427.7 17803.2 17933.1 17936.6 16529.6 17139.0 17504.7 17617.4 17626.3 4939.8 5184.7 5186.2 5188.9 5189.3 3812.6 3994.5 5106.6 5692.9 5946.9 6046.3 6047.2 6055.1 6061.4 6062.0 5759.6 5916.6 5933.4 5941.0 5943.9 3426.5 3603.2 3605.3 5232.2 5240.4 19498.3 20146.4 20832.7 21791.9 22020.9 1888.8 2109.4 2123.3 2284.9 2396.1 12922.9 13419.0 13743.6 13912.2 14137.4 1720.4 1720.4 1721.5 1737.1 1773.3 68210.3 69033.7 69682.3 69823.7 70516.0 9441.1 9679.1 9704.9 9934.0 10637.4 13426.1 13453.7 13468.5 13483.5 13496.2 7198.8 7499.0 7560.5 7585.9 7672.9 7339.2 7343.9 7546.5 7557.7 7571.8 6142.8 6260.5 6273.5 6275.6 6300.1 1649.9 1688.4 1755.2 1796.7 1825.9 841.0 906.1 910.9 922.6 933.6 17492.9 17691.4 18360.4 18534.4 18535.3 811.0 853.1 875.3 876.5 898.8 7987.9 9546.1 9727.7 9759.8 9943.3 399744.0 402437.0 407556.0 411611.0 429764.0 85049.0 86735.6 87198.6 87334.0 88557.6 833.4 898.9 921.9 952.4 955.5 15264.5 15753.8 16278.8 16919.9 16966.7 37602.6 38329.0 38601.6 38679.6 39425.4 49905.5 50404.0 53545.0 53996.0 54394.2 7702.4 7866.4 7984.9 7986.1 8004.3 11738.9 12081.2 12358.5 12393.9 13151.9 9972.5 10391.5 10396.8 10461.9 11327.4 10577.3 10639.5 10682.5 10882.2 11040.8 10724.6 11055.8 11139.9 11272.9 11376.7 7912.9 7961.1 7979.6 8168.3 8336.4 10231.7 10748.3 10947.9 10993.5 11160.9 14:08:18 INFO - PROCESS | 32079 | 14:08:18 INFO - PROCESS | 32079 | [#3] mootools.html Cycles:180 Average:5125.47 Median:5291.34 stddev:2859.49 (54.0%) stddev-sans-first:2853.71 14:08:18 INFO - PROCESS | 32079 | Values: 1386.5 1418.7 1498.2 1678.2 1725.7 7502.2 8076.8 8077.7 8084.9 8087.9 6799.3 7441.9 7660.0 7726.6 7894.9 2181.1 2207.4 2208.3 2208.4 2208.8 2201.5 2217.7 2247.1 2247.6 2249.9 1903.2 2136.6 2202.5 2203.3 2227.0 2203.8 2207.1 2226.5 2229.3 2231.6 2209.1 2215.8 2217.7 2220.0 2222.0 7945.6 7995.0 7996.0 7996.7 7999.0 4534.6 4587.4 4676.8 4681.7 4682.0 2740.9 2916.8 2922.2 2926.4 2927.4 913.8 940.0 955.3 978.7 979.4 10470.9 10529.8 10570.1 10607.3 10650.3 3887.7 4050.2 4191.9 4209.0 4224.6 9153.4 9186.4 9194.3 9194.6 9203.0 4645.1 4649.2 4650.9 4651.0 4653.9 4172.8 4241.9 4242.1 4242.3 4243.3 3611.5 3613.3 3660.9 3755.6 3756.8 1145.8 1167.9 1182.1 1185.5 1188.1 659.9 667.2 697.5 738.8 748.7 5074.4 5097.7 5169.9 5183.9 5231.4 811.0 831.7 883.6 889.2 890.7 3380.7 3502.2 3530.2 3541.7 3586.9 9188.8 9513.0 9625.4 9648.5 9649.1 9574.7 9576.8 9581.7 9587.5 9600.8 6008.6 6271.4 7086.0 7188.9 7350.9 5209.8 5351.3 5390.2 5468.4 5617.8 8653.9 8730.4 8807.0 8843.6 8853.2 8802.9 8903.4 8994.5 9049.4 9054.0 6764.1 6799.1 6866.4 6870.1 6871.4 7439.1 7485.7 7501.5 7503.2 7509.3 6451.1 6667.3 6706.8 6824.1 6827.9 6558.5 6688.0 6709.0 6744.4 6754.8 6278.7 6302.8 6349.0 6360.0 6452.7 4321.0 4499.1 4522.0 4579.8 4755.9 4512.6 4546.7 4604.8 4631.7 4655.2 14:08:18 INFO - PROCESS | 32079 | 14:08:18 INFO - PROCESS | 32079 | [#4] prototype.html Cycles:180 Average:4201.61 Median:4821.33 stddev:1208.83 (25.1%) stddev-sans-first:1176.21 14:08:18 INFO - PROCESS | 32079 | Values: 300.0 302.3 305.8 306.6 309.1 4804.5 4828.5 4851.4 4854.4 4873.4 4815.6 4822.4 4848.8 4849.4 4858.2 3649.0 3696.4 3725.3 3743.2 3764.2 3766.7 3788.8 3800.6 3806.4 3811.4 3755.3 3758.2 3761.7 3774.6 3774.6 3613.1 3655.5 3768.9 3784.9 3787.4 3359.5 3359.9 3367.2 3374.7 3379.3 4720.2 4727.8 4730.3 4736.9 4738.3 4218.7 4354.2 4367.1 4371.6 4378.3 4957.7 5008.2 5012.3 5023.2 5029.5 3698.3 3711.0 3714.1 3715.3 3720.5 5065.1 5259.6 5303.1 5312.2 5344.4 3748.2 3759.7 3761.7 3771.2 3776.2 3798.6 3803.3 3809.5 3813.1 3831.4 4332.7 4341.8 4346.8 4351.2 4353.7 4837.8 4992.0 4997.6 5047.6 5084.5 1281.9 1295.7 1296.5 1298.2 1298.7 835.4 838.9 848.0 853.8 870.6 4421.7 4437.1 4441.0 4462.2 4466.5 5116.5 5136.2 5144.2 5146.4 5152.3 4348.4 4429.3 4433.7 4437.1 4438.7 2714.9 2736.2 2742.6 2747.3 2755.4 4874.4 4879.2 4881.4 4889.9 4927.3 5063.8 5267.4 5278.5 5294.0 5303.9 4820.2 4846.8 4872.2 4882.8 4883.0 5091.8 5103.4 5113.6 5125.7 5127.5 4736.7 4998.4 4998.4 5023.7 5113.8 4927.1 4930.6 4940.4 4944.3 4953.5 3682.9 3728.9 3745.3 3754.4 3761.8 5099.2 5307.4 5308.7 5317.1 5327.7 5013.8 5080.4 5096.9 5141.9 5165.4 5024.6 5067.6 5069.5 5112.7 5117.9 4769.5 4993.5 5011.6 5023.4 5024.9 4769.7 4843.5 5000.7 5019.4 5039.9 4955.5 4956.2 4957.5 4967.5 4979.2 14:08:18 INFO - PROCESS | 32079 | 14:08:18 INFO - PROCESS | 32079 | [#5] yui.html Cycles:180 Average:17186.56 Median:497.21 stddev:24020.19 (4831.0%) stddev-sans-first:24055.40 14:08:18 INFO - PROCESS | 32079 | Values: 628.9 638.4 665.3 768.6 778.2 13171.9 14393.9 14417.9 14473.9 14479.9 12607.1 12938.3 12965.5 13711.2 13848.7 625.5 753.8 790.7 808.4 809.6 794.4 808.6 808.7 809.4 809.4 853.9 855.1 855.5 855.7 856.0 643.0 782.2 843.5 843.6 843.6 601.9 602.8 603.0 603.3 603.8 14013.7 14032.4 14051.9 14055.0 14066.2 12591.9 12708.4 12845.6 13037.4 13357.2 10760.3 11015.1 11024.6 11236.3 11291.2 4161.6 4182.1 4218.1 4227.0 4296.6 67536.3 67598.7 67730.0 67806.0 67871.3 9812.7 9885.5 10025.4 10071.7 10390.6 18285.7 18403.2 18419.8 18437.8 18484.5 6996.0 7018.0 7070.2 7178.6 7181.3 3695.0 3702.5 3706.0 3738.7 3813.6 2765.2 2856.2 2861.6 2882.0 2891.0 483.8 488.5 497.6 499.9 504.2 496.8 510.4 511.9 518.3 547.5 7433.6 7546.7 7665.5 7801.4 8216.8 510.8 517.8 530.0 531.4 532.1 3623.8 3681.5 3785.6 3800.1 3812.1 60298.4 60663.0 62568.0 63008.7 63196.0 89901.6 90774.0 95625.5 96578.0 97427.0 61358.4 82880.6 83094.0 84691.0 85195.0 7945.1 8251.5 8467.2 8501.3 8560.5 31125.2 32535.0 40999.2 41262.6 42492.6 56220.4 60159.9 60779.0 63394.4 64278.7 9896.2 10378.5 10662.0 11058.3 11389.5 11681.5 12054.9 12115.5 12787.2 12855.7 11574.9 11928.7 12091.6 12099.3 12275.1 11996.3 12507.9 12735.5 12755.7 12997.4 10897.3 11456.3 11499.9 11856.9 12344.3 9899.2 10110.5 10445.4 10518.7 10773.1 8885.7 9865.2 9923.3 10035.2 10106.8 14:08:18 INFO - PROCESS | 32079 | -------- Summary: end -------- 14:08:18 INFO - PROCESS | 32079 | 14:08:19 INFO - TEST-INFO | 32079: exit 0 14:08:19 INFO - TEST-OK | dromaeo_css | took 1121534ms 14:08:19 INFO - TEST-START | kraken 14:08:19 INFO - operating with platform_type : linux_ 14:08:19 INFO - Initialising browser for kraken test... 14:08:19 INFO - TEST-INFO | started process 32267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiYQLfT/profile http://localhost:52572/getInfo.html) 14:08:24 INFO - PROCESS | 32267 | __metrics Screen width/height:1600/1200 14:08:24 INFO - PROCESS | 32267 | colorDepth:24 14:08:24 INFO - PROCESS | 32267 | Browser inner width/height: 1024/697 14:08:24 INFO - PROCESS | 32267 | __metrics 14:08:25 INFO - PROCESS | 32267 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:08:25 INFO - PROCESS | 32267 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:08:26 INFO - TEST-INFO | 32267: exit 0 14:08:26 INFO - Browser initialized. 14:08:26 INFO - Running cycle 1/1 for kraken test... 14:08:26 INFO - TEST-INFO | started process 32350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiYQLfT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:38 INFO - PROCESS | 32350 | RSS: Main: 158683136 14:08:38 INFO - PROCESS | 32350 | 14:08:41 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52572/tests/kraken/driver.html?testName=audio-beat-detection) 14:08:42 INFO - PROCESS | 32350 | RSS: Main: 215719936 14:08:42 INFO - PROCESS | 32350 | 14:08:44 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52572/tests/kraken/driver.html?testName=audio-dft) 14:08:45 INFO - PROCESS | 32350 | RSS: Main: 192036864 14:08:45 INFO - PROCESS | 32350 | 14:08:48 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52572/tests/kraken/driver.html?testName=audio-fft) 14:08:49 INFO - PROCESS | 32350 | RSS: Main: 271769600 14:08:49 INFO - PROCESS | 32350 | 14:08:51 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52572/tests/kraken/driver.html?testName=audio-oscillator) 14:08:52 INFO - PROCESS | 32350 | RSS: Main: 180862976 14:08:52 INFO - PROCESS | 32350 | 14:08:54 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52572/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:08:55 INFO - PROCESS | 32350 | RSS: Main: 185888768 14:08:55 INFO - PROCESS | 32350 | 14:08:58 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52572/tests/kraken/driver.html?testName=imaging-darkroom) 14:08:58 INFO - PROCESS | 32350 | RSS: Main: 222519296 14:08:58 INFO - PROCESS | 32350 | 14:09:02 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52572/tests/kraken/driver.html?testName=imaging-desaturate) 14:09:02 INFO - PROCESS | 32350 | RSS: Main: 222892032 14:09:02 INFO - PROCESS | 32350 | 14:09:05 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52572/tests/kraken/driver.html?testName=json-parse-financial) 14:09:06 INFO - PROCESS | 32350 | RSS: Main: 221958144 14:09:06 INFO - PROCESS | 32350 | 14:09:08 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52572/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:08 INFO - PROCESS | 32350 | RSS: Main: 186695680 14:09:08 INFO - PROCESS | 32350 | 14:09:10 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52572/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:09:11 INFO - PROCESS | 32350 | RSS: Main: 192008192 14:09:11 INFO - PROCESS | 32350 | 14:09:13 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52572/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:09:14 INFO - PROCESS | 32350 | RSS: Main: 196390912 14:09:14 INFO - PROCESS | 32350 | 14:09:16 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:09:17 INFO - PROCESS | 32350 | RSS: Main: 190902272 14:09:17 INFO - PROCESS | 32350 | 14:09:20 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:09:20 INFO - PROCESS | 32350 | RSS: Main: 194289664 14:09:20 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:52572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52572/tests/kraken/driver.html?testName=ai-astar) 14:09:22 INFO - PROCESS | 32350 | RSS: Main: 245653504 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | __start_tp_report 14:09:22 INFO - PROCESS | 32350 | _x_x_mozilla_page_load 14:09:22 INFO - PROCESS | 32350 | _x_x_mozilla_page_load_details 14:09:22 INFO - PROCESS | 32350 | |i|pagename|runs| 14:09:22 INFO - PROCESS | 32350 | |0;ai-astar;105;115;112;114;113;115;114;113;117;113 14:09:22 INFO - PROCESS | 32350 | |1;audio-beat-detection;146;123;128;186;123;121;154;122;191;122 14:09:22 INFO - PROCESS | 32350 | |2;audio-dft;160;161;160;160;160;161;160;161;162;163 14:09:22 INFO - PROCESS | 32350 | |3;audio-fft;76;84;77;106;76;77;75;75;98;75 14:09:22 INFO - PROCESS | 32350 | |4;audio-oscillator;84;85;113;85;86;85;114;85;85;127 14:09:22 INFO - PROCESS | 32350 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;118;118;117 14:09:22 INFO - PROCESS | 32350 | |6;imaging-darkroom;146;146;146;146;146;147;146;147;145;147 14:09:22 INFO - PROCESS | 32350 | |7;imaging-desaturate;97;95;96;96;96;95;96;96;95;95 14:09:22 INFO - PROCESS | 32350 | |8;json-parse-financial;64;63;63;64;63;63;62;64;64;64 14:09:22 INFO - PROCESS | 32350 | |9;json-stringify-tinderbox;65;66;66;65;66;65;66;66;65;65 14:09:22 INFO - PROCESS | 32350 | |10;stanford-crypto-aes;85;80;88;78;79;88;81;79;78;84 14:09:22 INFO - PROCESS | 32350 | |11;stanford-crypto-ccm;129;138;141;129;144;133;129;125;182;128 14:09:22 INFO - PROCESS | 32350 | |12;stanford-crypto-pbkdf2;164;164;164;165;163;164;162;162;162;161 14:09:22 INFO - PROCESS | 32350 | |13;stanford-crypto-sha256-iterative;67;65;71;67;70;67;70;65;66;65 14:09:22 INFO - PROCESS | 32350 | __end_tp_report 14:09:22 INFO - PROCESS | 32350 | __start_cc_report 14:09:22 INFO - PROCESS | 32350 | _x_x_mozilla_cycle_collect,1944 14:09:22 INFO - PROCESS | 32350 | __end_cc_report 14:09:22 INFO - PROCESS | 32350 | __startTimestamp1469048962933__endTimestamp 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | ------- Summary: start ------- 14:09:22 INFO - PROCESS | 32350 | Number of tests: 14 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.18 (2.8%) stddev-sans-first:1.50 14:09:22 INFO - PROCESS | 32350 | Values: 105.0 115.0 112.0 114.0 113.0 115.0 114.0 113.0 117.0 113.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:137.00 stddev:27.19 (19.8%) stddev-sans-first:28.79 14:09:22 INFO - PROCESS | 32350 | Values: 146.0 123.0 128.0 186.0 123.0 121.0 154.0 122.0 191.0 122.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 14:09:22 INFO - PROCESS | 32350 | Values: 160.0 161.0 160.0 160.0 160.0 161.0 160.0 161.0 162.0 163.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.50 stddev:11.08 (14.5%) stddev-sans-first:11.54 14:09:22 INFO - PROCESS | 32350 | Values: 76.0 84.0 77.0 106.0 76.0 77.0 75.0 75.0 98.0 75.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:85.00 stddev:16.37 (19.3%) stddev-sans-first:16.88 14:09:22 INFO - PROCESS | 32350 | Values: 84.0 85.0 113.0 85.0 86.0 85.0 114.0 85.0 85.0 127.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:09:22 INFO - PROCESS | 32350 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 118.0 117.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:09:22 INFO - PROCESS | 32350 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 145.0 147.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 14:09:22 INFO - PROCESS | 32350 | Values: 97.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 14:09:22 INFO - PROCESS | 32350 | Values: 64.0 63.0 63.0 64.0 63.0 63.0 62.0 64.0 64.0 64.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 14:09:22 INFO - PROCESS | 32350 | Values: 65.0 66.0 66.0 65.0 66.0 65.0 66.0 66.0 65.0 65.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:3.94 (4.8%) stddev-sans-first:4.03 14:09:22 INFO - PROCESS | 32350 | Values: 85.0 80.0 88.0 78.0 79.0 88.0 81.0 79.0 78.0 84.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:135.50 stddev:16.73 (12.3%) stddev-sans-first:17.43 14:09:22 INFO - PROCESS | 32350 | Values: 129.0 138.0 141.0 129.0 144.0 133.0 129.0 125.0 182.0 128.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:164.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 14:09:22 INFO - PROCESS | 32350 | Values: 164.0 164.0 164.0 165.0 163.0 164.0 162.0 162.0 162.0 161.0 14:09:22 INFO - PROCESS | 32350 | 14:09:22 INFO - PROCESS | 32350 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.26 (3.4%) stddev-sans-first:2.40 14:09:22 INFO - PROCESS | 32350 | Values: 67.0 65.0 71.0 67.0 70.0 67.0 70.0 65.0 66.0 65.0 14:09:22 INFO - PROCESS | 32350 | -------- Summary: end -------- 14:09:22 INFO - PROCESS | 32350 | 14:09:23 INFO - TEST-INFO | 32350: exit 0 14:09:24 INFO - TEST-OK | kraken | took 64357ms 14:09:24 INFO - SUITE-END | took 1185s 14:09:24 INFO - Completed test suite (00:19:45) 14:09:24 INFO - javascript benchmark 14:09:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.4051268208314, 2593.1701855406277, 2623.0425894548484, 2638.4986852498014, 2645.6296118543405, 4594.150082234781, 4646.0, 4676.1349150407195, 4699.154152252593, 4704.929426058603, 4649.3490911272365, 4685.531446855312, 4725.031368569444, 4732.408448943882, 4756.191447453933, 4276.743395396271, 4285.721428107178, 4356.150550642626, 4415.73505589664, 4497.10057988402, 4415.779211039451, 4448.332750087497, 4456.108778244364, 4465.955340446602, 4471.441069866267, 4236.957630423718, 4285.185814695229, 4289.978550107261, 4317.719348242385, 4347.847825326098, 4335.609795118455, 4338.8047537860875, 4373.081652852905, 4385.101054283864, 4390.78046097697, 4365.519792822787, 4382.452193475816, 4398.692091553593, 4418.248897687401, 4421.248387774086, 4624.121416930806, 4778.593819525345, 4827.25177597473, 4841.515848415165, 4844.612431005511, 5032.119379108678, 5075.822346217865, 5081.085404627165, 5152.072626927152, 5158.92261616076, 5128.102582048164, 5145.536901678867, 5171.3277273954145, 5175.327207463043, 5176.430592634845, 4618.122556714214, 4757.09615173116, 4777.283407488835, 4823.589994850407, 4823.782929768169, 5178.223266510054, 5211.478852114758, 5227.424983251839, 5300.390455097636, 5334.626576139711, 5033.345665063592, 5045.8738531537, 5085.084684756779, 5089.033083714083, 5089.872753181126, 4887.706737595756, 5138.3577052868395, 5148.4079330876675, 5148.613853960968, 5160.767765450564, 4740.1230772307235, 4924.162892308244, 4949.703017818871, 4999.625028122905, 5040.823571174991, 4951.826686066042, 4959.578435832995, 4965.875853103701, 4970.179920313108, 5022.573081288131, 4228.640565551901, 4325.870223893288, 4335.544767799399, 4339.262325404688, 4386.780660966939, 3669.7247706422127, 3738.719596030309, 3774.8112594370173, 3793.1844653399653, 3874.9612503875164, 4393.143337049309, 4417.646588272931, 4418.226810308183, 4423.0, 4465.285554311295, 5121.514760719424, 5126.564242039469, 5126.615503837227, 5128.743562821918, 5174.818881339135, 4315.503717072514, 4351.891202719894, 4363.105563359503, 4387.451568553931, 4444.1333939881415, 4626.352310676508, 4626.537346265347, 4633.72197668141, 4649.116667833101, 4684.8360307389075, 4758.571728544448, 4776.116418462596, 4794.137055330074, 4802.567768900815, 4847.079054979543, 4828.758562071953, 5037.924431133462, 5066.746662666778, 5072.137736584863, 5156.819511317086, 4757.9048419032115, 4793.664443489062, 4796.472388037243, 4802.51974802517, 4861.902761944671, 5006.07387633289, 5014.42334131565, 5031.647784655185, 5032.773525191302, 5083.313752643346, 4937.136001199704, 4941.085899108676, 4960.206366981266, 4983.327250821093, 5030.547250747304, 4849.927251091166, 4851.417829860439, 4855.028994201244, 4863.927041094315, 4903.7302948336755, 4833.347498087714, 4854.029194161111, 4866.294387313749, 4870.366852309177, 4923.606111510999, 4777.8327758528285, 4795.160846851857, 4797.856064318076, 4803.711777293373, 4906.681065730716, 4891.26631005352, 4903.882902423695, 4909.509049095205, 4913.238448040559, 4965.900681986268, 4849.75751212445, 4862.756862156807, 4864.805407783649, 4865.391826021747, 4908.4355299139625], "value": 4654.221607890729, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.4323020209993, 575.6431012772082, 583.8277708076117, 600.327633050983, 602.2983224543407, 27523.449531009366, 39750.0, 40851.38722919158, 40883.0, 44778.32832507507, 42271.0, 42554.574454255446, 42734.35898461525, 42758.786206069, 42761.786191069004, 7542.736004239852, 7843.411744119199, 7982.600869956508, 8002.0, 8005.279524842763, 9939.453330066843, 10204.132648724868, 10218.48907554623, 10583.682489525327, 10594.894051059468, 10376.636817711382, 10458.581656733722, 10466.790664186712, 10479.633212837552, 10484.947575262113, 7562.205968373351, 9995.650152244709, 10263.332883362595, 10318.277720559563, 10321.84517232242, 9879.456629885353, 9952.950235248778, 9959.452230127341, 9964.70105896817, 9979.251556133318, 39218.60781392206, 39576.80211598952, 39577.60422395797, 39592.60407395918, 39609.40585891214, 3051.67957364478, 3249.96750032499, 3576.5708115026105, 3664.047347689593, 3902.4926759521363, 29858.85070574655, 29881.850590747126, 30071.849640751876, 30107.0967870962, 31382.215444613837, 3506.596741374749, 3541.4333706606817, 3548.6273941236313, 3626.3110009098186, 3656.561212654472, 258713.0, 259541.0, 261210.0, 261279.0, 261751.0, 32350.35299294001, 55181.0, 55624.16563751547, 55806.0, 55828.0, 32573.674263257537, 34388.0, 34495.13762155916, 34505.65494345075, 34565.82717086399, 13080.738385232242, 13160.276184809927, 13164.210147390995, 13175.736485270241, 13179.868201318055, 9025.729228123168, 10895.673129806119, 11039.83440248397, 11101.389423581619, 11171.66485005451, 7900.920990790133, 7913.366930645535, 7976.561289129154, 7980.321672657889, 8038.718644847402, 3150.5116706910467, 3150.684931506831, 3150.9054728358187, 3157.2422618571836, 3181.1887968567867, 889.7241855024963, 917.495377542349, 947.3889341374775, 1006.0643601450721, 1038.6987773545738, 27874.860625697147, 29350.0, 29498.0, 29786.851065744966, 29787.702122978928, 974.8099120671543, 976.7069879036261, 981.47000619666, 1029.156092004549, 1049.8477720730605, 14909.776353354708, 15791.447299344467, 15822.446214382671, 16239.756403653955, 16389.180540972902, 417415.0, 423593.0, 423712.0, 426285.0, 426699.0, 52395.73802130965, 52773.472265277625, 52838.94322113536, 52839.207411888856, 52882.206766898526, 1083.864516935383, 1120.8991190792867, 1137.3858116616934, 1199.8860108289698, 1213.5267245774155, 23166.536669266858, 29454.558181626864, 29644.851775740983, 32052.83973580117, 32237.0, 47861.0, 48554.75722621506, 48556.0, 48582.0, 48627.51372486371, 359071.0, 361496.0, 362830.0, 362923.0, 363297.0, 22142.0, 22517.32448026562, 23152.0, 25756.484870302866, 26146.738532615193, 38668.0, 41140.0, 42354.78822605867, 42430.36354454624, 42469.0, 36383.0, 36737.26525469529, 37102.44346334861, 37714.811425942695, 39528.0, 37381.813090934374, 37598.43602345912, 40086.198276033734, 41179.7941010293, 41438.79280603577, 39345.40981885217, 39817.40273895836, 40127.39808902927, 40145.0, 40174.0, 38210.2357952845, 39093.41359879661, 39940.807694999465, 40133.397999030625, 40544.0, 23182.420439488473, 23924.404108906372, 24615.38461538476, 24743.0, 24842.875785620956], "value": 17555.34042378109, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.2646028562019, 364.08977556109744, 370.2225326813691, 378.7765218521072, 381.81100355324116, 16661.83338166618, 17427.738583921237, 17803.198856051462, 17933.103344832773, 17936.551586210353, 16529.586760330996, 17139.0, 17504.737428938544, 17617.383391581297, 17626.294948202056, 4939.77771000305, 5184.7407629618365, 5186.196139598368, 5188.922166167492, 5189.299444574972, 3812.6377994090517, 3994.4807175067344, 5106.5659418949435, 5692.943070569283, 5946.910796338037, 6046.304674962392, 6047.15339852421, 6055.061465472859, 6061.424164704368, 6061.969690151543, 5759.560109972507, 5916.615419997708, 5933.406659334075, 5940.97029514854, 5943.851403714899, 3426.468897320919, 3603.1532589841368, 3605.3330133925047, 5232.241325007891, 5240.3973543042275, 19498.317558885512, 20146.39560813178, 20832.687509687366, 21791.891040544855, 22020.88989555058, 1888.8111188881003, 2109.440998135495, 2123.278085450954, 2284.851484653509, 2396.113438027941, 12922.935385323108, 13419.0, 13743.587692369245, 13912.165270083828, 14137.363818628186, 1720.3894507987568, 1720.4064597713768, 1721.5320346685025, 1737.0880287848854, 1773.3172728499621, 68210.3178968209, 69033.65483172602, 69682.30317696859, 69823.65088174578, 70515.99999999949, 9441.103095205945, 9679.096271118777, 9704.9029509704, 9933.991761377765, 10637.414942178255, 13426.127301725357, 13453.730925381633, 13468.461261549428, 13483.460661573623, 13496.190228586316, 7198.820029499199, 7499.0, 7560.470767046254, 7585.924140758521, 7672.923270767333, 7339.192688804227, 7343.926560734324, 7546.547207167588, 7557.697692092364, 7571.772846814604, 6142.78500252498, 6260.530460215502, 6273.52948528853, 6275.623462592259, 6300.117983482316, 1649.909254990987, 1688.4174959638906, 1755.2013833705632, 1796.6765982123343, 1825.917833697487, 840.9663613455516, 906.0857097339431, 910.9180173784391, 922.5986695787354, 933.6078846884325, 17492.912535437496, 17691.38080167188, 18360.357387491375, 18534.351297704787, 18535.258589656263, 810.9513429194267, 853.1383302864028, 875.3391189651772, 876.5354362188051, 898.81574277273, 7987.920120798718, 9546.140847323773, 9727.708168754949, 9759.804803903882, 9943.303968722264, 399744.0, 402437.0, 407556.0, 411611.0, 429764.0, 85049.0, 86735.56632216799, 87198.56400717956, 87334.0, 88557.55721221482, 833.3832963606887, 898.9370744047985, 921.9308551858637, 952.3666761603595, 955.5126885288414, 15264.465743698916, 15753.767474590353, 16278.755818662492, 16919.91540042292, 16966.745498817774, 37602.62397375991, 38329.0, 38601.6139838598, 38679.6132038676, 39425.40861887131, 49905.50094499008, 50404.0, 53545.0, 53996.0, 54394.18408723951, 7702.383809295131, 7866.449348545547, 7984.880226796487, 7986.081600616004, 8004.319632831274, 11738.94130529342, 12081.214721043105, 12358.505659773868, 12393.938030310152, 13151.934240328737, 9972.50137493137, 10391.532381043022, 10396.844047339448, 10461.947690261804, 11327.376994265065, 10577.259591828499, 10639.521221544894, 10682.465876706288, 10882.183836212474, 11040.834387484354, 10724.624638137628, 11055.834162487408, 11139.888601113886, 11272.887271127183, 11376.658700239006, 7912.881306780518, 7961.124276329483, 7979.640916158903, 8168.305694016075, 8336.374771892253, 10231.693049208536, 10748.301360411548, 10947.890521095005, 10993.450327483433, 11160.944195278971], "value": 8574.311452673011, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.4939297156538, 1418.7233489469552, 1498.2059508460513, 1678.2364024368912, 1725.7066298729223, 7502.249775022502, 8076.757697269077, 8077.717279895205, 8084.919150808505, 8087.8786818197705, 6799.252082270958, 7441.888371674429, 7659.961700191505, 7726.575038372887, 7894.881576776353, 2181.094845639058, 2207.3708992937018, 2208.326460429568, 2208.4147700859285, 2208.7901649343366, 2201.504661451169, 2217.6784366266884, 2247.1011595361824, 2247.6179049561533, 2249.9437514062197, 1903.2101677803694, 2136.6154092263387, 2202.5044365017825, 2203.3059586230365, 2226.9888650556804, 2203.7575866654734, 2207.128184367166, 2226.476777957179, 2229.320057382498, 2231.5871563760757, 2209.127394679109, 2215.8116560092412, 2217.700610417589, 2220.012094617896, 2222.0445208560313, 7945.602719864041, 7994.960025199837, 7995.960020199862, 7996.68013279474, 7998.960005199937, 4534.569215924482, 4587.42657167854, 4676.789544470507, 4681.74250416227, 4681.953180468186, 2740.945181096367, 2916.8104073235386, 2922.167182353019, 2926.356201635637, 2927.443785680714, 913.7761248494095, 939.9812003759955, 955.2644463762933, 978.6770365779275, 979.3829887171108, 10470.895291047143, 10529.84205236922, 10570.101541368993, 10607.310524815863, 10650.25448218625, 3887.6501114899793, 4050.210209009215, 4191.895202619898, 4209.0, 4224.619784219435, 9153.35926485153, 9186.448813071103, 9194.31042671789, 9194.586243619053, 9203.0, 4645.140648979882, 4649.209634362167, 4650.86047418578, 4650.9767451162525, 4653.906921861611, 4172.833086676499, 4241.915161696748, 4242.087951090469, 4242.257604919127, 4243.342281946303, 3611.476335931328, 3613.2954073955852, 3660.890173294805, 3755.586885442599, 3756.7933763643264, 1145.7651181507772, 1167.8656954450346, 1182.0720734223594, 1185.4783895086134, 1188.085174415695, 659.9406053455212, 667.1793693756609, 697.4838619421591, 738.7968308715147, 748.6518768772547, 5074.416442109131, 5097.668651537638, 5169.870753231124, 5183.948160518346, 5231.424543300234, 810.9837803243902, 831.7047448155938, 883.6332921837494, 889.1775108025051, 890.670451932789, 3380.7464440167087, 3502.2295095079044, 3530.1704099536587, 3541.6812486876306, 3586.9282614347567, 9188.816223675489, 9513.04869513057, 9625.422474651403, 9648.469334186546, 9649.083337082966, 9574.664886728931, 9576.808463830825, 9581.664641737645, 9587.472689002032, 9600.807983840285, 6008.609440386361, 6271.43557079865, 7085.964570177116, 7188.928110718931, 7350.852982940204, 5209.791608335624, 5351.2508248844415, 5390.19147127934, 5468.371137319259, 5617.8033768817895, 8653.870191947251, 8730.388872779098, 8807.0, 8843.585026396004, 8853.15894989975, 8802.867956980523, 8903.421277616933, 8994.505302208441, 9049.366544341832, 9054.049324820799, 6764.086848275617, 6799.082123913208, 6866.416354609914, 6870.072540207008, 6871.415929646036, 7439.144498382755, 7485.663145158372, 7501.474896757175, 7503.1746507883, 7509.324160825552, 6451.0645956337, 6667.299933506912, 6706.83232919181, 6824.07874936897, 6827.93172068273, 6558.540902136805, 6687.966560167168, 6708.966455167693, 6744.359285867835, 6754.763583274562, 6278.6546739929745, 6302.842428939313, 6349.0, 6360.045993101072, 6452.677366131768, 4320.978395108004, 4499.077689073667, 4521.9547804521535, 4579.816807327803, 4755.857324280277, 4512.616427603691, 4546.704464209815, 4604.769761511844, 4631.745254011062, 4655.162070827284], "value": 4125.660787764198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.9940001199976, 302.30771533188994, 305.7752551874373, 306.6197914585914, 309.0804855554725, 4804.543568361005, 4828.537445902593, 4851.417829860417, 4854.3689320388385, 4873.439554451239, 4815.590674792638, 4822.4454187768415, 4848.7575621218975, 4849.418069831625, 4858.222684370501, 3648.9635103648957, 3696.3900956342172, 3725.2921944830396, 3743.232637309359, 3764.171882185915, 3766.6986641068784, 3788.7916164610933, 3800.5937803012926, 3806.4100064489908, 3811.4473401356927, 3755.324041672498, 3758.154415256559, 3761.6990640748813, 3774.622537746217, 3774.641409066148, 3613.0606042429026, 3655.524781778365, 3768.9246215075545, 3784.9053773655605, 3787.3750831112834, 3359.4792807114936, 3359.882404115844, 3367.1582104473882, 3374.6794054564775, 3379.3410284994434, 4720.221163508051, 4727.834525791581, 4730.337752714623, 4736.857894263143, 4738.312944623045, 4218.704690671623, 4354.194474022316, 4367.126574685076, 4371.562843715635, 4378.277584198603, 4957.727324997124, 5008.247113510279, 5012.273220383024, 5023.171176755831, 5029.497050294978, 3698.33429982603, 3711.0165806061414, 3714.052916506301, 3715.294094122135, 3720.5163328767358, 5065.138926382524, 5259.605529585297, 5303.124984377573, 5312.184542192644, 5344.385395679469, 3748.231612519427, 3759.680427163667, 3761.6990640748672, 3771.2080463102507, 3776.169242766587, 3798.601146879593, 3803.2773772983046, 3809.466674665549, 3813.122981714221, 3831.4061320495366, 4332.67504937131, 4341.848035318749, 4346.847860324937, 4351.19502891966, 4353.673474489426, 4837.806487740521, 4991.9500804991485, 4997.625178111583, 5047.621428392885, 5084.51697088776, 1281.858995510493, 1295.7149427126017, 1296.5202874936333, 1298.2210673595766, 1298.69480672042, 835.415209353455, 838.9244967952914, 847.9915200848036, 853.7780177153985, 870.573419024686, 4421.668374871833, 4437.134758722018, 4440.977795111068, 4462.196804575207, 4466.508684044752, 5116.539511443988, 5136.152534831711, 5144.151215049475, 5146.408163061295, 5152.3044389007755, 4348.369486424514, 4429.313456414261, 4433.672322030895, 4437.112577484451, 4438.7114837535455, 2714.9457010859674, 2736.2475319287355, 2742.6023226632424, 2747.3406382468065, 2755.3800394911386, 4874.4150701916, 4879.243717223836, 4881.438634557, 4889.853304400874, 4927.310176575283, 5063.822766203239, 5267.367915850046, 5278.498542638443, 5294.0, 5303.920441193385, 4820.204666230103, 4846.830360937351, 4872.244802055616, 4882.8281212509455, 4882.950165714388, 5091.821786237612, 5103.362079740033, 5113.616478764033, 5125.718085505333, 5127.512886275797, 4736.73947932867, 4998.400191976986, 4998.400191976986, 5023.748812559431, 5113.7698803553185, 4927.063857866994, 4930.630202734737, 4940.382452193476, 4944.307796908363, 4953.479884612208, 3682.944755828611, 3728.944065839069, 3745.2509498099944, 3754.4368344748505, 3761.830717617659, 5099.184130539096, 5307.389650190123, 5308.708021058879, 5317.1492561190025, 5327.680339179662, 5013.799448022039, 5080.415752188545, 5096.923546146885, 5141.897162056813, 5165.431802501646, 5024.648274620741, 5067.569256613082, 5069.518395752398, 5112.71880046601, 5117.8976420470635, 4769.499202583679, 4993.526909561615, 5011.624128190328, 5023.372078490189, 5024.924626130538, 4769.666123371469, 4843.539863712942, 5000.724960127228, 5019.3976722793495, 5039.924401134059, 4955.479674634112, 4956.231784073474, 4957.504249575014, 4967.4535801062575, 4979.178435558092], "value": 3817.2312310788802, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.8710814283072, 638.3903372279474, 665.3246954341341, 768.5888049893308, 778.2062296457611, 13171.868281317184, 14393.928030359833, 14417.855821441783, 14473.927630361846, 14479.927600361983, 12607.117501774857, 12938.288394138342, 12965.481380744783, 13711.177329360245, 13848.653783655414, 625.5027253333611, 753.8040109571524, 790.7232468635989, 808.4462143431739, 809.5911564659868, 794.4081659163902, 808.5795386399069, 808.745245247748, 809.3565615335792, 809.3889113719164, 853.9146085391442, 855.0679759062621, 855.529458797662, 855.6748435594496, 855.9614817333235, 642.9967850160766, 782.2334112569657, 843.5107637570195, 843.6372359885247, 843.641452382741, 601.9307779605314, 602.8462742000805, 602.9577929544934, 603.3031848215319, 603.8399824046631, 14013.719725605431, 14032.43870245189, 14051.929740351336, 14055.016148869583, 14066.156030638194, 12591.937040314831, 12708.364581770875, 12845.614631561068, 13037.41331640069, 13357.198568085945, 10760.258341661356, 11015.118790496741, 11024.614138505114, 11236.325820450798, 11291.20961532693, 4161.633635066672, 4182.100848317596, 4218.11419601884, 4227.0, 4296.613304802583, 67536.32463675349, 67598.66200669014, 67730.0, 67806.0, 67871.32128678699, 9812.705618831447, 9885.50572471388, 10025.448600327052, 10071.697849064392, 10390.584376625002, 18285.725714114298, 18403.17185726619, 18419.81580184181, 18437.81562184361, 18484.537886552946, 6996.0, 7018.0, 7070.186928503185, 7178.605176715227, 7181.281871812881, 3694.9815250923575, 3702.4631428442726, 3706.0, 3738.700903927679, 3813.6056721790733, 2765.2395591212176, 2856.200263926104, 2861.642294713161, 2882.0489238551645, 2890.956635650467, 483.7605385334212, 488.47976904597203, 497.5913407212098, 499.8725325042164, 504.2285303485673, 496.83604410544433, 510.4002796713846, 511.94880511949253, 518.2821791818359, 547.460751160107, 7433.591152486665, 7546.735864244725, 7665.501742386727, 7801.375889928792, 8216.794580135544, 510.75483767791667, 517.834293026228, 529.9973500132475, 531.3915566676134, 532.0990218477108, 3623.7644553103964, 3681.4845921571, 3785.5835858055593, 3800.144967382372, 3812.066043819282, 60298.39701602928, 60663.0, 62568.0, 63008.68495657492, 63196.0, 89901.55049224843, 90774.0, 95625.52187239019, 96578.0, 97427.0, 61358.38641613527, 82880.58559707283, 83094.0, 84691.0, 85195.0, 7945.1260361359045, 8251.546164960984, 8467.15328467173, 8501.319894408556, 8560.529170895661, 31125.221869453446, 32535.0, 40999.1800164001, 41262.58737412588, 42492.57507424886, 56220.437795623155, 60159.86243232749, 60779.0, 63394.36605633885, 64278.67860660667, 9896.20830333586, 10378.481075946022, 10662.0, 11058.281211721212, 11389.544418223179, 11681.532738690697, 12054.859609093155, 12115.515379384726, 12787.232766034067, 12855.678608034874, 11574.942125289657, 11928.701782455508, 12091.637250882488, 12099.33453660057, 12275.140740148105, 11996.340201289013, 12507.93746031264, 12735.490580377053, 12755.681107972376, 12997.415116319598, 10897.291676041032, 11456.255343402652, 11499.942500287445, 11856.881431185579, 12344.321062341658, 9899.20806335477, 10110.496689070564, 10445.373277603368, 10518.684439466828, 10773.138148948223, 8885.733427997171, 9865.161461275871, 9923.305368624127, 10035.19718422539, 10106.797864042825], "value": 6524.134942540595, "unit": "score"}], "name": "dromaeo_css", "value": 6449.783380334582, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 112.0, 114.0, 113.0, 115.0, 114.0, 113.0, 117.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 128.0, 186.0, 123.0, 121.0, 154.0, 122.0, 191.0, 122.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 162.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 77.0, 106.0, 76.0, 77.0, 75.0, 75.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 113.0, 85.0, 86.0, 85.0, 114.0, 85.0, 85.0, 127.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, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 145.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 64.0, 64.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 88.0, 78.0, 79.0, 88.0, 81.0, 79.0, 78.0, 84.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 138.0, 141.0, 129.0, 144.0, 133.0, 129.0, 125.0, 182.0, 128.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 165.0, 163.0, 164.0, 162.0, 162.0, 162.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 71.0, 67.0, 70.0, 67.0, 70.0, 65.0, 66.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1530.3999999999996, "alertThreshold": 2.0}]} 14:09:24 INFO - Return code: 0 14:09:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:09:24 INFO - # TBPL SUCCESS # 14:09:24 INFO - Running post-action listener: _resource_record_post_action 14:09:24 INFO - [mozharness: 2016-07-20 21:09:24.236135Z] Finished run-tests step (success) 14:09:24 INFO - Running post-run listener: _resource_record_post_run 14:09:24 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545959936; Read time: 20; Write time: 979652 14:09:24 INFO - TinderboxPrint: CPU usage
13.0% 14:09:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 14:09:24 INFO - TinderboxPrint: I/O write bytes / time
545,959,936 / 979,652 14:09:24 INFO - TinderboxPrint: CPU idle
8,351.3 (87.0%) 14:09:24 INFO - TinderboxPrint: CPU user
1,198.4 (12.5%) 14:09:24 INFO - TinderboxPrint: Swap in / out
0 / 0 14:09:24 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 246718464; Read time: 0; Write time: 566000 14:09:24 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 299241472; Read time: 0; Write time: 413652 14:09:24 INFO - Running post-run listener: _upload_blobber_files 14:09:24 INFO - Blob upload gear active. 14:09:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:09:24 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 14:09:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:09:25 INFO - (blobuploader) - INFO - Open directory for files ... 14:09:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:09:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:09:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:39 INFO - (blobuploader) - INFO - Done attempting. 14:09:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:09:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:09:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:40 INFO - (blobuploader) - INFO - Done attempting. 14:09:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:09:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:09:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:41 INFO - (blobuploader) - INFO - Done attempting. 14:09:41 INFO - (blobuploader) - INFO - Iteration through files over. 14:09:41 INFO - Return code: 0 14:09:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:09:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:09:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f506ae874bc22e65915a402000d49a7eb7fc1e0b3602d919f17b5cc5e85dfc8d01cfca5a26ff5e15505722ffb87c871ac6916cfb738acca4ad448abba3e83d0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d62e658d6ec80dd20bc52b624c595b4edf5329e367b621fcbfb553b357725880d3141c35ad702f8bf6dd7a0d6104c0f8e5e2cd5ead3e0b52e5753dab2b4e6a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d62fada971fb2023f2686eaaea2fd57e979c74b2c93bbca7b2aa5522393c128dd4d4a05834ed89cb6435c7ec1d598932a1d522ebf60c4665ecb99d4e3e463ba"} 14:09:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:09:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:09:41 INFO - Contents: 14:09:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f506ae874bc22e65915a402000d49a7eb7fc1e0b3602d919f17b5cc5e85dfc8d01cfca5a26ff5e15505722ffb87c871ac6916cfb738acca4ad448abba3e83d0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d62e658d6ec80dd20bc52b624c595b4edf5329e367b621fcbfb553b357725880d3141c35ad702f8bf6dd7a0d6104c0f8e5e2cd5ead3e0b52e5753dab2b4e6a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d62fada971fb2023f2686eaaea2fd57e979c74b2c93bbca7b2aa5522393c128dd4d4a05834ed89cb6435c7ec1d598932a1d522ebf60c4665ecb99d4e3e463ba"} 14:09:41 INFO - Running post-run listener: copy_logs_to_upload_dir 14:09:41 INFO - Copying logs to upload dir... 14:09:41 INFO - mkdir: /builds/slave/test/build/upload/logs 14:09:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.499151 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-20 14:09:41.182160) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 14:09:41.185331) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095 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-Non-PGO/sha512/f506ae874bc22e65915a402000d49a7eb7fc1e0b3602d919f17b5cc5e85dfc8d01cfca5a26ff5e15505722ffb87c871ac6916cfb738acca4ad448abba3e83d0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d62e658d6ec80dd20bc52b624c595b4edf5329e367b621fcbfb553b357725880d3141c35ad702f8bf6dd7a0d6104c0f8e5e2cd5ead3e0b52e5753dab2b4e6a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d62fada971fb2023f2686eaaea2fd57e979c74b2c93bbca7b2aa5522393c128dd4d4a05834ed89cb6435c7ec1d598932a1d522ebf60c4665ecb99d4e3e463ba"} build_url:https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/V-z4Doz8RLmiHEncX-81pQ/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-Non-PGO/sha512/f506ae874bc22e65915a402000d49a7eb7fc1e0b3602d919f17b5cc5e85dfc8d01cfca5a26ff5e15505722ffb87c871ac6916cfb738acca4ad448abba3e83d0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d62e658d6ec80dd20bc52b624c595b4edf5329e367b621fcbfb553b357725880d3141c35ad702f8bf6dd7a0d6104c0f8e5e2cd5ead3e0b52e5753dab2b4e6a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d62fada971fb2023f2686eaaea2fd57e979c74b2c93bbca7b2aa5522393c128dd4d4a05834ed89cb6435c7ec1d598932a1d522ebf60c4665ecb99d4e3e463ba"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 14:09:41.211171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:09:41.211709) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1469047726.979405-598034095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:09:41.298410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 14:09:41.299117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 14:09:41.299683) ========= ========= Total master_lag: 0.19 =========