builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1468985820.57 results: success (0) buildid: 20160718105252 builduid: 3a678ddbbdff44509ee2e29603f57976 revision: 2a69345f4f4eeb804e6a96c70f086f10e9849724 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:00.574437) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:00.574900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:00.575181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:00.589927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:00.590235) ========= 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=52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 20:37:01-- 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% 69.3M=0s 2016-07-19 20:37:01 (69.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:00.686922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:00.687240) ========= 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=52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021102 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:00.735986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 20:37:00.736353) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2a69345f4f4eeb804e6a96c70f086f10e9849724 --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 2a69345f4f4eeb804e6a96c70f086f10e9849724 --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=52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 20:37:01,425 truncating revision to first 12 chars 2016-07-19 20:37:01,426 Setting DEBUG logging. 2016-07-19 20:37:01,426 attempt 1/10 2016-07-19 20:37:01,426 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2a69345f4f4e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 20:37:02,858 unpacking tar archive at: autoland-2a69345f4f4e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.774980 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 20:37:02.524635) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:02.524953) ========= script_repo_revision: 2a69345f4f4eeb804e6a96c70f086f10e9849724 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:02.525350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:02.525612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 20:37:02.533753) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-19 20:37:02.534024) ========= /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=52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:37:03 INFO - MultiFileLogger online at 20160719 20:37:03 in /builds/slave/test 20:37:03 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 20:37:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:37:03 INFO - {'append_to_log': False, 20:37:03 INFO - 'base_work_dir': '/builds/slave/test', 20:37:03 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:37:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:37:03 INFO - 'branch': 'Autoland-Non-PGO', 20:37:03 INFO - 'buildbot_json_path': 'buildprops.json', 20:37:03 INFO - 'config_files': ('talos/linux_config.py',), 20:37:03 INFO - 'default_actions': ('clobber', 20:37:03 INFO - 'read-buildbot-config', 20:37:03 INFO - 'download-and-extract', 20:37:03 INFO - 'populate-webroot', 20:37:03 INFO - 'create-virtualenv', 20:37:03 INFO - 'install', 20:37:03 INFO - 'run-tests'), 20:37:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:37:03 INFO - 'download_minidump_stackwalk': True, 20:37:03 INFO - 'download_symbols': 'ondemand', 20:37:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:37:03 INFO - 'tooltool.py': '/tools/tooltool.py', 20:37:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:37:03 INFO - '/tools/misc-python/virtualenv.py')}, 20:37:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:37:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:37:03 INFO - 'installer_path': 'installer.exe', 20:37:03 INFO - 'log_level': 'info', 20:37:03 INFO - 'log_name': 'talos', 20:37:03 INFO - 'log_to_console': True, 20:37:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:37:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:37:03 INFO - 'opt_config_files': (), 20:37:03 INFO - 'pip_index': False, 20:37:03 INFO - 'sps_profile': False, 20:37:03 INFO - 'sps_profile_interval': 0, 20:37:03 INFO - 'suite': 'dromaeojs', 20:37:03 INFO - 'system_bits': '32', 20:37:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:37:03 INFO - 'title': 'talos-linux64-ix-056', 20:37:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:37:03 INFO - 'use_talos_json': True, 20:37:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:37:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:37:03 INFO - 'work_dir': 'build'} 20:37:03 INFO - ##### 20:37:03 INFO - ##### Running clobber step. 20:37:03 INFO - ##### 20:37:03 INFO - Running pre-action listener: _resource_record_pre_action 20:37:03 INFO - Running main action method: clobber 20:37:03 INFO - rmtree: /builds/slave/test/build 20:37:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:37:03 INFO - Running post-action listener: _resource_record_post_action 20:37:03 INFO - ##### 20:37:03 INFO - ##### Finished clobber step (success) 20:37:03 INFO - ##### 20:37:03 INFO - ##### 20:37:03 INFO - ##### Running read-buildbot-config step. 20:37:03 INFO - ##### 20:37:03 INFO - Running pre-action listener: _resource_record_pre_action 20:37:03 INFO - Running main action method: read_buildbot_config 20:37:03 INFO - Using buildbot properties: 20:37:03 INFO - { 20:37:03 INFO - "project": "", 20:37:03 INFO - "product": "firefox", 20:37:03 INFO - "script_repo_revision": "production", 20:37:03 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 20:37:03 INFO - "repository": "", 20:37:03 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 20:37:03 INFO - "buildid": "20160718105252", 20:37:03 INFO - "pgo_build": "False", 20:37:03 INFO - "basedir": "/builds/slave/test", 20:37:03 INFO - "buildnumber": 73, 20:37:03 INFO - "slavename": "talos-linux64-ix-056", 20:37:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:37:03 INFO - "platform": "ubuntu64_hw", 20:37:03 INFO - "scheduler": "tests-autoland-linux64-talos", 20:37:03 INFO - "branch": "autoland", 20:37:03 INFO - "repo_path": "integration/autoland", 20:37:03 INFO - "revision": "2a69345f4f4eeb804e6a96c70f086f10e9849724", 20:37:03 INFO - "stage_platform": "linux64", 20:37:03 INFO - "builduid": "3a678ddbbdff44509ee2e29603f57976", 20:37:03 INFO - "slavebuilddir": "test" 20:37:03 INFO - } 20:37:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:37:03 INFO - Running post-action listener: _resource_record_post_action 20:37:03 INFO - ##### 20:37:03 INFO - ##### Finished read-buildbot-config step (success) 20:37:03 INFO - ##### 20:37:03 INFO - ##### 20:37:03 INFO - ##### Running download-and-extract step. 20:37:03 INFO - ##### 20:37:03 INFO - Running pre-action listener: _resource_record_pre_action 20:37:03 INFO - Running main action method: download_and_extract 20:37:03 INFO - mkdir: /builds/slave/test/build/tests 20:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:03 INFO - https://queue.taskcluster.net/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:37:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:37:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:37:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/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 20:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/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 20:37:04 INFO - Downloaded 1361 bytes. 20:37:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:37:04 INFO - Using the following test package requirements: 20:37:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:37:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:37:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:37:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:04 INFO - u'jsshell-linux-x86_64.zip'], 20:37:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:37:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:37:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:37:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:37:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:37:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:37:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:04 INFO - https://queue.taskcluster.net/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:37:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:37:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:37:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/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 20:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/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 20:37:05 INFO - Downloaded 22764883 bytes. 20:37:05 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'] 20:37:05 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 20:37:06 INFO - Return code: 0 20:37:06 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 20:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:06 INFO - https://queue.taskcluster.net/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:37:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:37:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:37:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/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 20:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/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 20:37:07 INFO - Downloaded 22764883 bytes. 20:37:07 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'] 20:37:07 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 20:37:09 INFO - Return code: 0 20:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:09 INFO - https://queue.taskcluster.net/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:37:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:37:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:37:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/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 20:37:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/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 20:37:10 INFO - Downloaded 14403317 bytes. 20:37:10 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'] 20:37:10 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 20:37:10 INFO - Return code: 0 20:37: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')]} 20:37:10 INFO - https://queue.taskcluster.net/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:37:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:37:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:37:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/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 20:37:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_XgzBDeRYGXjjK15H2d4w/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 20:37:11 INFO - Downloaded 57133058 bytes. 20:37:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:37:11 INFO - mkdir: /builds/slave/test/properties 20:37:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:37:11 INFO - Writing to file /builds/slave/test/properties/build_url 20:37:11 INFO - Contents: 20:37:11 INFO - build_url:https://queue.taskcluster.net/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:37:12 INFO - Running post-action listener: _resource_record_post_action 20:37:12 INFO - Running post-action listener: set_extra_try_arguments 20:37:12 INFO - ##### 20:37:12 INFO - ##### Finished download-and-extract step (success) 20:37:12 INFO - ##### 20:37:12 INFO - ##### 20:37:12 INFO - ##### Running populate-webroot step. 20:37:12 INFO - ##### 20:37:12 INFO - Running pre-action listener: _resource_record_pre_action 20:37:12 INFO - Running main action method: populate_webroot 20:37:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:37:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:37:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:37:12 INFO - '--tppagecycles', 20:37:12 INFO - '7'], 20:37:12 INFO - 'tests': ['tsvgm']}}, 20:37:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:37:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:37:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:37:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:37:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:12 INFO - 'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:37:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:37:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:12 INFO - 'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['damp', 'tps']}, 20:37:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:12 INFO - 'tests': ['damp', 'tps']}, 20:37:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['dromaeo_dom']}, 20:37:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:37:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['basic_compositor_video']}, 20:37:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:37:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['a11yr', 20:37:12 INFO - 'ts_paint', 20:37:12 INFO - 'tpaint', 20:37:12 INFO - 'sessionrestore', 20:37:12 INFO - 'sessionrestore_no_auto_restore', 20:37:12 INFO - 'tabpaint']}, 20:37:12 INFO - 'other-e10s': {'tests': ['a11yr', 20:37:12 INFO - 'ts_paint', 20:37:12 INFO - 'tpaint', 20:37:12 INFO - 'sessionrestore', 20:37:12 INFO - 'sessionrestore_no_auto_restore', 20:37:12 INFO - 'tabpaint']}, 20:37:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:37:12 INFO - 'ts_paint', 20:37:12 INFO - 'tpaint', 20:37:12 INFO - 'sessionrestore', 20:37:12 INFO - 'sessionrestore_no_auto_restore', 20:37:12 INFO - 'tabpaint']}, 20:37:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:37:12 INFO - 'ts_paint', 20:37:12 INFO - 'tpaint', 20:37:12 INFO - 'sessionrestore', 20:37:12 INFO - 'sessionrestore_no_auto_restore', 20:37:12 INFO - 'tabpaint']}, 20:37:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['a11yr', 20:37:12 INFO - 'ts_paint', 20:37:12 INFO - 'tpaint', 20:37:12 INFO - 'sessionrestore', 20:37:12 INFO - 'sessionrestore_no_auto_restore', 20:37:12 INFO - 'tabpaint']}, 20:37:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['a11yr', 20:37:12 INFO - 'ts_paint', 20:37:12 INFO - 'tpaint', 20:37:12 INFO - 'sessionrestore', 20:37:12 INFO - 'sessionrestore_no_auto_restore', 20:37:12 INFO - 'tabpaint']}, 20:37:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['tsvgx', 20:37:12 INFO - 'tsvgr_opacity', 20:37:12 INFO - 'tart', 20:37:12 INFO - 'tscrollx', 20:37:12 INFO - 'cart']}, 20:37:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:37:12 INFO - 'tsvgr_opacity', 20:37:12 INFO - 'tart', 20:37:12 INFO - 'tscrollx', 20:37:12 INFO - 'cart']}, 20:37:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:12 INFO - 'talos_options': ['--disable-e10s'], 20:37:12 INFO - 'tests': ['tp5o']}, 20:37:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:12 INFO - 'tests': ['tp5o']}, 20:37:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:12 INFO - 'talos_options': ['--disable-e10s', 20:37:12 INFO - '--xperf_path', 20:37:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:37:12 INFO - 'tests': ['tp5n']}, 20:37:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:12 INFO - 'talos_options': ['--xperf_path', 20:37:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:37:12 INFO - 'tests': ['tp5n']}}, 20:37:12 INFO - 'talos.zip': {'path': '', 20:37:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:37:12 INFO - Running post-action listener: _resource_record_post_action 20:37:12 INFO - ##### 20:37:12 INFO - ##### Finished populate-webroot step (success) 20:37:12 INFO - ##### 20:37:12 INFO - ##### 20:37:12 INFO - ##### Running create-virtualenv step. 20:37:12 INFO - ##### 20:37:12 INFO - Running pre-action listener: _resource_record_pre_action 20:37:12 INFO - Running main action method: create_virtualenv 20:37:12 INFO - Creating virtualenv /builds/slave/test/build/venv 20:37:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:37:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:37:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:37:12 INFO - Using real prefix '/usr' 20:37:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:37:13 INFO - Installing distribute.............................................................................................................................................................................................done. 20:37:15 INFO - Installing pip.................done. 20:37:15 INFO - Return code: 0 20:37:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:15 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 0x134f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1610180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e3b0>, '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 0x160f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160f740>, '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': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:37:15 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 20:37:15 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 20:37:15 INFO - Using env: {'DISPLAY': ':0', 20:37:15 INFO - 'HOME': '/home/cltbld', 20:37:15 INFO - 'LANG': 'en_US.UTF-8', 20:37:15 INFO - 'LANGUAGE': 'en_US:en', 20:37:15 INFO - 'LOGNAME': 'cltbld', 20:37:15 INFO - 'MAIL': '/var/mail/cltbld', 20:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:15 INFO - 'MOZ_NO_REMOTE': '1', 20:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:15 INFO - 'NO_EM_RESTART': '1', 20:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:15 INFO - 'PWD': '/builds/slave/test', 20:37:15 INFO - 'SHELL': '/bin/bash', 20:37:15 INFO - 'SHLVL': '1', 20:37:15 INFO - 'TERM': 'linux', 20:37:15 INFO - 'TMOUT': '86400', 20:37:15 INFO - 'USER': 'cltbld', 20:37:15 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 20:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:15 INFO - '_': '/tools/buildbot/bin/python'} 20:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:15 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 20:37:15 INFO - Cleaning up... 20:37:15 INFO - Return code: 0 20:37:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:15 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 0x134f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1610180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e3b0>, '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 0x160f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160f740>, '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': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:37:15 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 20:37:15 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 20:37:15 INFO - Using env: {'DISPLAY': ':0', 20:37:15 INFO - 'HOME': '/home/cltbld', 20:37:15 INFO - 'LANG': 'en_US.UTF-8', 20:37:15 INFO - 'LANGUAGE': 'en_US:en', 20:37:15 INFO - 'LOGNAME': 'cltbld', 20:37:15 INFO - 'MAIL': '/var/mail/cltbld', 20:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:15 INFO - 'MOZ_NO_REMOTE': '1', 20:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:15 INFO - 'NO_EM_RESTART': '1', 20:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:15 INFO - 'PWD': '/builds/slave/test', 20:37:15 INFO - 'SHELL': '/bin/bash', 20:37:15 INFO - 'SHLVL': '1', 20:37:15 INFO - 'TERM': 'linux', 20:37:15 INFO - 'TMOUT': '86400', 20:37:15 INFO - 'USER': 'cltbld', 20:37:15 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 20:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:15 INFO - '_': '/tools/buildbot/bin/python'} 20:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:15 INFO - Downloading/unpacking psutil>=3.1.1 20:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:37:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:37:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:37:17 INFO - Installing collected packages: psutil 20:37:17 INFO - Running setup.py install for psutil 20:37:17 INFO - building 'psutil._psutil_linux' extension 20:37:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:37:18 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 20:37:18 INFO - building 'psutil._psutil_posix' extension 20:37:18 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 20:37:18 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 20:37:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:37:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:37:18 INFO - Successfully installed psutil 20:37:18 INFO - Cleaning up... 20:37:18 INFO - Return code: 0 20:37:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:18 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 0x134f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1610180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e3b0>, '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 0x160f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160f740>, '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': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:37:18 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 20:37:18 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 20:37:18 INFO - Using env: {'DISPLAY': ':0', 20:37:18 INFO - 'HOME': '/home/cltbld', 20:37:18 INFO - 'LANG': 'en_US.UTF-8', 20:37:18 INFO - 'LANGUAGE': 'en_US:en', 20:37:18 INFO - 'LOGNAME': 'cltbld', 20:37:18 INFO - 'MAIL': '/var/mail/cltbld', 20:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:18 INFO - 'MOZ_NO_REMOTE': '1', 20:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:18 INFO - 'NO_EM_RESTART': '1', 20:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:18 INFO - 'PWD': '/builds/slave/test', 20:37:18 INFO - 'SHELL': '/bin/bash', 20:37:18 INFO - 'SHLVL': '1', 20:37:18 INFO - 'TERM': 'linux', 20:37:18 INFO - 'TMOUT': '86400', 20:37:18 INFO - 'USER': 'cltbld', 20:37:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 20:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:18 INFO - '_': '/tools/buildbot/bin/python'} 20:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:37: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 20:37: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 20:37: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 20:37: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 20:37: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 20:37: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 20:37:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:37:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:37:20 INFO - Installing collected packages: mozsystemmonitor 20:37:20 INFO - Running setup.py install for mozsystemmonitor 20:37:20 INFO - Successfully installed mozsystemmonitor 20:37:20 INFO - Cleaning up... 20:37:20 INFO - Return code: 0 20:37:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:37: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')]} 20:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37: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')]} 20:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1610180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e3b0>, '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 0x160f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160f740>, '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': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:37:20 INFO - Using env: {'DISPLAY': ':0', 20:37:20 INFO - 'HOME': '/home/cltbld', 20:37:20 INFO - 'LANG': 'en_US.UTF-8', 20:37:20 INFO - 'LANGUAGE': 'en_US:en', 20:37:20 INFO - 'LOGNAME': 'cltbld', 20:37:20 INFO - 'MAIL': '/var/mail/cltbld', 20:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:20 INFO - 'MOZ_NO_REMOTE': '1', 20:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:20 INFO - 'NO_EM_RESTART': '1', 20:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:20 INFO - 'PWD': '/builds/slave/test', 20:37:20 INFO - 'SHELL': '/bin/bash', 20:37:20 INFO - 'SHLVL': '1', 20:37:20 INFO - 'TERM': 'linux', 20:37:20 INFO - 'TMOUT': '86400', 20:37:20 INFO - 'USER': 'cltbld', 20:37:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 20:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:20 INFO - '_': '/tools/buildbot/bin/python'} 20:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:20 INFO - Downloading/unpacking jsonschema==2.5.1 20:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:37:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:23 INFO - Downloading functools32-3.2.3-2.tar.gz 20:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:37:23 INFO - warning: no files found matching '*.txt' 20:37:23 INFO - no previously-included directories found matching 'build' 20:37:23 INFO - no previously-included directories found matching 'dist' 20:37:23 INFO - no previously-included directories found matching '.git*' 20:37:23 INFO - Installing collected packages: jsonschema, functools32 20:37:23 INFO - Running setup.py install for functools32 20:37:23 INFO - warning: no files found matching '*.txt' 20:37:23 INFO - no previously-included directories found matching 'build' 20:37:23 INFO - no previously-included directories found matching 'dist' 20:37:23 INFO - no previously-included directories found matching '.git*' 20:37:23 INFO - Successfully installed jsonschema functools32 20:37:23 INFO - Cleaning up... 20:37:23 INFO - Return code: 0 20:37:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:23 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 0x134f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1610180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e3b0>, '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 0x160f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160f740>, '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': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:37:23 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 20:37:23 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 20:37:23 INFO - Using env: {'DISPLAY': ':0', 20:37:23 INFO - 'HOME': '/home/cltbld', 20:37:23 INFO - 'LANG': 'en_US.UTF-8', 20:37:23 INFO - 'LANGUAGE': 'en_US:en', 20:37:23 INFO - 'LOGNAME': 'cltbld', 20:37:23 INFO - 'MAIL': '/var/mail/cltbld', 20:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:23 INFO - 'MOZ_NO_REMOTE': '1', 20:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:23 INFO - 'NO_EM_RESTART': '1', 20:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:23 INFO - 'PWD': '/builds/slave/test', 20:37:23 INFO - 'SHELL': '/bin/bash', 20:37:23 INFO - 'SHLVL': '1', 20:37:23 INFO - 'TERM': 'linux', 20:37:23 INFO - 'TMOUT': '86400', 20:37:23 INFO - 'USER': 'cltbld', 20:37:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 20:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:23 INFO - '_': '/tools/buildbot/bin/python'} 20:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:23 INFO - Downloading/unpacking blobuploader==1.2.4 20:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:25 INFO - Downloading blobuploader-1.2.4.tar.gz 20:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:37:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:37:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:26 INFO - Downloading docopt-0.6.1.tar.gz 20:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:37:26 INFO - Installing collected packages: blobuploader, requests, docopt 20:37:26 INFO - Running setup.py install for blobuploader 20:37:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:37:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:37:26 INFO - Running setup.py install for requests 20:37:26 INFO - Running setup.py install for docopt 20:37:26 INFO - Successfully installed blobuploader requests docopt 20:37:26 INFO - Cleaning up... 20:37:26 INFO - Return code: 0 20:37:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1610180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e3b0>, '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 0x160f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160f740>, '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': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:37:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:37:26 INFO - Using env: {'DISPLAY': ':0', 20:37:26 INFO - 'HOME': '/home/cltbld', 20:37:26 INFO - 'LANG': 'en_US.UTF-8', 20:37:26 INFO - 'LANGUAGE': 'en_US:en', 20:37:26 INFO - 'LOGNAME': 'cltbld', 20:37:26 INFO - 'MAIL': '/var/mail/cltbld', 20:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:26 INFO - 'MOZ_NO_REMOTE': '1', 20:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:26 INFO - 'NO_EM_RESTART': '1', 20:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:26 INFO - 'PWD': '/builds/slave/test', 20:37:26 INFO - 'SHELL': '/bin/bash', 20:37:26 INFO - 'SHLVL': '1', 20:37:26 INFO - 'TERM': 'linux', 20:37:26 INFO - 'TMOUT': '86400', 20:37:26 INFO - 'USER': 'cltbld', 20:37:26 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 20:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:26 INFO - '_': '/tools/buildbot/bin/python'} 20:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:37:27 INFO - Running setup.py (path:/tmp/pip-wIA_sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:37:27 INFO - Running setup.py (path:/tmp/pip-fwjgqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:37:27 INFO - Running setup.py (path:/tmp/pip-2T_CPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:37:27 INFO - Running setup.py (path:/tmp/pip-2_FPfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:37:27 INFO - Running setup.py (path:/tmp/pip-tQEftT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:37:27 INFO - Running setup.py (path:/tmp/pip-BW5EVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:37:27 INFO - Running setup.py (path:/tmp/pip-32XoeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:37:27 INFO - Running setup.py (path:/tmp/pip-pRtwV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:37:27 INFO - Running setup.py (path:/tmp/pip-DaFjng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:37:27 INFO - Running setup.py (path:/tmp/pip-fP5c8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:37:27 INFO - Running setup.py (path:/tmp/pip-vxa3DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:37:27 INFO - Running setup.py (path:/tmp/pip-W67B8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:37:27 INFO - Running setup.py (path:/tmp/pip-8SGxEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:37:27 INFO - Running setup.py (path:/tmp/pip-L1bvEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:37:28 INFO - Running setup.py (path:/tmp/pip-xzcXKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:37:28 INFO - Running setup.py (path:/tmp/pip-zjpbYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:37:28 INFO - Running setup.py (path:/tmp/pip-DvGsX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:37:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:37:28 INFO - Running setup.py install for manifestparser 20:37:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:37:28 INFO - Running setup.py install for mozcrash 20:37:28 INFO - Running setup.py install for mozdebug 20:37:28 INFO - Running setup.py install for mozdevice 20:37:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:37:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:37:28 INFO - Running setup.py install for mozfile 20:37:28 INFO - Running setup.py install for mozhttpd 20:37:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:37:28 INFO - Running setup.py install for mozinfo 20:37:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:37:28 INFO - Running setup.py install for mozInstall 20:37:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:37:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:37:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:37:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:37:29 INFO - Running setup.py install for mozleak 20:37:29 INFO - Running setup.py install for mozlog 20:37:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:37:29 INFO - Running setup.py install for moznetwork 20:37:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:37:29 INFO - Running setup.py install for mozprocess 20:37:29 INFO - Running setup.py install for mozprofile 20:37:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:37:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:37:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:37:29 INFO - Running setup.py install for mozrunner 20:37:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:37:29 INFO - Running setup.py install for mozscreenshot 20:37:29 INFO - Running setup.py install for moztest 20:37:29 INFO - Running setup.py install for mozversion 20:37:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:37:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:37:30 INFO - Cleaning up... 20:37:30 INFO - Return code: 0 20:37:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:30 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 0x134f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1610180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e3b0>, '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 0x160f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160f740>, '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': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:37:30 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 20:37:30 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 20:37:30 INFO - Using env: {'DISPLAY': ':0', 20:37:30 INFO - 'HOME': '/home/cltbld', 20:37:30 INFO - 'LANG': 'en_US.UTF-8', 20:37:30 INFO - 'LANGUAGE': 'en_US:en', 20:37:30 INFO - 'LOGNAME': 'cltbld', 20:37:30 INFO - 'MAIL': '/var/mail/cltbld', 20:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:30 INFO - 'MOZ_NO_REMOTE': '1', 20:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:30 INFO - 'NO_EM_RESTART': '1', 20:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:30 INFO - 'PWD': '/builds/slave/test', 20:37:30 INFO - 'SHELL': '/bin/bash', 20:37:30 INFO - 'SHLVL': '1', 20:37:30 INFO - 'TERM': 'linux', 20:37:30 INFO - 'TMOUT': '86400', 20:37:30 INFO - 'USER': 'cltbld', 20:37:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 20:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:30 INFO - '_': '/tools/buildbot/bin/python'} 20:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:37:30 INFO - Running setup.py (path:/tmp/pip-ZoW48O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:37:30 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)) 20:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:37:30 INFO - Running setup.py (path:/tmp/pip-afF8Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:37:30 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)) 20:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:37:30 INFO - Running setup.py (path:/tmp/pip-QuVYmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:37:30 INFO - Running setup.py (path:/tmp/pip-Ba6gXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:37:30 INFO - Running setup.py (path:/tmp/pip-WWwgke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:37:30 INFO - Running setup.py (path:/tmp/pip-WZn_XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:37:30 INFO - Running setup.py (path:/tmp/pip-inavLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:37:30 INFO - Running setup.py (path:/tmp/pip-JhFD4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:37:30 INFO - Running setup.py (path:/tmp/pip-OlHix_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:37:30 INFO - Running setup.py (path:/tmp/pip-P79eFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:37:31 INFO - Running setup.py (path:/tmp/pip-nlGhOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:37:31 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)) 20:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:37:31 INFO - Running setup.py (path:/tmp/pip-2VPSi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:37:31 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)) 20:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:37:31 INFO - Running setup.py (path:/tmp/pip-wrSYuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:37:31 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)) 20:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:37:31 INFO - Running setup.py (path:/tmp/pip-CpJ_Qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:37:31 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)) 20:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:37:31 INFO - Running setup.py (path:/tmp/pip-jGroj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:37:31 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)) 20:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:37:31 INFO - Running setup.py (path:/tmp/pip-gD48In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:37:31 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)) 20:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:37:31 INFO - Running setup.py (path:/tmp/pip-tbFCZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:37:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:33 INFO - Downloading blessings-1.6.tar.gz 20:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:37:33 INFO - Installing collected packages: blessings 20:37:33 INFO - Running setup.py install for blessings 20:37:33 INFO - Successfully installed blessings 20:37:33 INFO - Cleaning up... 20:37:33 INFO - Return code: 0 20:37:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:37:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:37:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:37:33 INFO - Reading from file tmpfile_stdout 20:37:33 INFO - Current package versions: 20:37:33 INFO - argparse == 1.2.1 20:37:33 INFO - blessings == 1.6 20:37:33 INFO - blobuploader == 1.2.4 20:37:33 INFO - docopt == 0.6.1 20:37:33 INFO - functools32 == 3.2.3-2 20:37:33 INFO - jsonschema == 2.5.1 20:37:33 INFO - manifestparser == 1.1 20:37:33 INFO - mozInstall == 1.12 20:37:33 INFO - mozcrash == 0.17 20:37:33 INFO - mozdebug == 0.1 20:37:33 INFO - mozdevice == 0.48 20:37:33 INFO - mozfile == 1.2 20:37:33 INFO - mozhttpd == 0.7 20:37:33 INFO - mozinfo == 0.9 20:37:33 INFO - mozleak == 0.1 20:37:33 INFO - mozlog == 3.2 20:37:33 INFO - moznetwork == 0.27 20:37:33 INFO - mozprocess == 0.23 20:37:33 INFO - mozprofile == 0.28 20:37:33 INFO - mozrunner == 6.12 20:37:33 INFO - mozscreenshot == 0.1 20:37:33 INFO - mozsystemmonitor == 0.3 20:37:33 INFO - moztest == 0.7 20:37:33 INFO - mozversion == 1.4 20:37:33 INFO - psutil == 3.1.1 20:37:33 INFO - requests == 1.2.3 20:37:33 INFO - wsgiref == 0.1.2 20:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1610180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e3b0>, '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 0x160f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160f740>, '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': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:37:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:37:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:37:33 INFO - Using env: {'DISPLAY': ':0', 20:37:33 INFO - 'HOME': '/home/cltbld', 20:37:33 INFO - 'LANG': 'en_US.UTF-8', 20:37:33 INFO - 'LANGUAGE': 'en_US:en', 20:37:33 INFO - 'LOGNAME': 'cltbld', 20:37:33 INFO - 'MAIL': '/var/mail/cltbld', 20:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:33 INFO - 'MOZ_NO_REMOTE': '1', 20:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:33 INFO - 'NO_EM_RESTART': '1', 20:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:33 INFO - 'PWD': '/builds/slave/test', 20:37:33 INFO - 'SHELL': '/bin/bash', 20:37:33 INFO - 'SHLVL': '1', 20:37:33 INFO - 'TERM': 'linux', 20:37:33 INFO - 'TMOUT': '86400', 20:37:33 INFO - 'USER': 'cltbld', 20:37:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 20:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:33 INFO - '_': '/tools/buildbot/bin/python'} 20:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:37:34 INFO - Cleaning up... 20:37:34 INFO - Return code: 0 20:37:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1610180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e3b0>, '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 0x160f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160f740>, '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': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:37:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:37:34 INFO - Using env: {'DISPLAY': ':0', 20:37:34 INFO - 'HOME': '/home/cltbld', 20:37:34 INFO - 'LANG': 'en_US.UTF-8', 20:37:34 INFO - 'LANGUAGE': 'en_US:en', 20:37:34 INFO - 'LOGNAME': 'cltbld', 20:37:34 INFO - 'MAIL': '/var/mail/cltbld', 20:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:34 INFO - 'MOZ_NO_REMOTE': '1', 20:37:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:34 INFO - 'NO_EM_RESTART': '1', 20:37:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:34 INFO - 'PWD': '/builds/slave/test', 20:37:34 INFO - 'SHELL': '/bin/bash', 20:37:34 INFO - 'SHLVL': '1', 20:37:34 INFO - 'TERM': 'linux', 20:37:34 INFO - 'TMOUT': '86400', 20:37:34 INFO - 'USER': 'cltbld', 20:37:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 20:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:34 INFO - '_': '/tools/buildbot/bin/python'} 20:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:37:34 INFO - Cleaning up... 20:37:34 INFO - Return code: 0 20:37:34 INFO - Running post-action listener: _resource_record_post_action 20:37:34 INFO - Running post-action listener: _start_resource_monitoring 20:37:34 INFO - Starting resource monitoring. 20:37:34 INFO - ##### 20:37:34 INFO - ##### Finished create-virtualenv step (success) 20:37:34 INFO - ##### 20:37:34 INFO - ##### 20:37:34 INFO - ##### Running install step. 20:37:34 INFO - ##### 20:37:34 INFO - Running pre-action listener: _resource_record_pre_action 20:37:34 INFO - Running main action method: install 20:37:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:37:34 INFO - Reading from file tmpfile_stdout 20:37:34 INFO - Detecting whether we're running mozinstall >=1.0... 20:37:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:37:34 INFO - Reading from file tmpfile_stdout 20:37:34 INFO - Output received: 20:37:34 INFO - Usage: mozinstall [options] installer 20:37:34 INFO - Options: 20:37:34 INFO - -h, --help show this help message and exit 20:37:34 INFO - -d DEST, --destination=DEST 20:37:34 INFO - Directory to install application into. [default: 20:37:34 INFO - "/builds/slave/test"] 20:37:34 INFO - --app=APP Application being installed. [default: firefox] 20:37:34 INFO - mkdir: /builds/slave/test/build/application 20:37:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:37:51 INFO - Reading from file tmpfile_stdout 20:37:51 INFO - Output received: 20:37:51 INFO - /builds/slave/test/build/application/firefox/firefox 20:37:51 INFO - Running post-action listener: _resource_record_post_action 20:37:51 INFO - ##### 20:37:51 INFO - ##### Finished install step (success) 20:37:51 INFO - ##### 20:37:51 INFO - ##### 20:37:51 INFO - ##### Running run-tests step. 20:37:51 INFO - ##### 20:37:51 INFO - Running pre-action listener: _resource_record_pre_action 20:37:51 INFO - Running main action method: run_tests 20:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:37:51 INFO - Python 2.7.3 20:37:51 INFO - Return code: 0 20:37:51 INFO - grabbing minidump binary from tooltool 20:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:51 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 0x160e3b0>, '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 0x160f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:37:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:37:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:37:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:37:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:37:51 INFO - Return code: 0 20:37:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:37:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:37:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:37:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:37:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:37:51 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/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:37:51 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/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:37:51 INFO - Using env: {'DISPLAY': ':0', 20:37:51 INFO - 'HOME': '/home/cltbld', 20:37:51 INFO - 'LANG': 'en_US.UTF-8', 20:37:51 INFO - 'LANGUAGE': 'en_US:en', 20:37:51 INFO - 'LOGNAME': 'cltbld', 20:37:51 INFO - 'MAIL': '/var/mail/cltbld', 20:37:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:37:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:51 INFO - 'MOZ_NO_REMOTE': '1', 20:37:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:51 INFO - 'NO_EM_RESTART': '1', 20:37:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:51 INFO - 'PWD': '/builds/slave/test', 20:37:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:37:51 INFO - 'SHELL': '/bin/bash', 20:37:51 INFO - 'SHLVL': '1', 20:37:51 INFO - 'TERM': 'linux', 20:37:51 INFO - 'TMOUT': '86400', 20:37:51 INFO - 'USER': 'cltbld', 20:37:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386', 20:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:51 INFO - '_': '/tools/buildbot/bin/python'} 20:37:51 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/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:37:51 INFO - mozversion application_buildid: 20160718105252 20:37:51 INFO - mozversion application_changeset: 2a69345f4f4eeb804e6a96c70f086f10e9849724 20:37:51 INFO - mozversion application_display_name: Nightly 20:37:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:37:51 INFO - mozversion application_name: Firefox 20:37:51 INFO - mozversion application_remotingname: firefox 20:37:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:37:51 INFO - mozversion application_vendor: Mozilla 20:37:51 INFO - mozversion application_version: 50.0a1 20:37:51 INFO - mozversion platform_buildid: 20160718105252 20:37:51 INFO - mozversion platform_changeset: 2a69345f4f4eeb804e6a96c70f086f10e9849724 20:37:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:37:51 INFO - mozversion platform_version: 50.0a1 20:37:51 INFO - using testdate: 1468985871 20:37:51 INFO - actual date: 1468985871 20:37:51 INFO - starting webserver on 'localhost:49488' 20:37:51 INFO - SUITE-START | Running 2 tests 20:37:51 INFO - TEST-START | dromaeo_css 20:37:51 INFO - operating with platform_type : linux_ 20:37:51 INFO - Initialising browser for dromaeo_css test... 20:37:51 INFO - TEST-INFO | started process 21140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSlmjqn/profile http://localhost:49488/getInfo.html) 20:37:55 INFO - PROCESS | 21140 | __metrics Screen width/height:1600/1200 20:37:55 INFO - PROCESS | 21140 | colorDepth:24 20:37:55 INFO - PROCESS | 21140 | Browser inner width/height: 1024/697 20:37:55 INFO - PROCESS | 21140 | __metrics 20:37:56 INFO - PROCESS | 21140 | 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" 20:37:56 INFO - PROCESS | 21140 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:37:57 INFO - TEST-INFO | 21140: exit 0 20:37:57 INFO - Browser initialized. 20:37:57 INFO - Running cycle 1/1 for dromaeo_css test... 20:37:57 INFO - TEST-INFO | started process 21218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSlmjqn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:38:09 INFO - PROCESS | 21218 | RSS: Main: 159358976 20:38:09 INFO - PROCESS | 21218 | 20:39:00 INFO - PROCESS | 21218 | 1468985940363 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:41:13 INFO - PROCESS | 21218 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49488/tests/dromaeo/cssquery-ext.html) 20:41:14 INFO - PROCESS | 21218 | RSS: Main: 269869056 20:41:14 INFO - PROCESS | 21218 | 20:44:17 INFO - PROCESS | 21218 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-ext.html (next: http://localhost:49488/tests/dromaeo/cssquery-jquery.html) 20:44:18 INFO - PROCESS | 21218 | RSS: Main: 248827904 20:44:18 INFO - PROCESS | 21218 | 20:47:20 INFO - PROCESS | 21218 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49488/tests/dromaeo/cssquery-mootools.html) 20:47:20 INFO - PROCESS | 21218 | RSS: Main: 247160832 20:47:20 INFO - PROCESS | 21218 | 20:50:23 INFO - PROCESS | 21218 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49488/tests/dromaeo/cssquery-prototype.html) 20:50:23 INFO - PROCESS | 21218 | RSS: Main: 237985792 20:50:23 INFO - PROCESS | 21218 | 20:53:26 INFO - PROCESS | 21218 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49488/tests/dromaeo/cssquery-yui.html) 20:53:27 INFO - PROCESS | 21218 | RSS: Main: 221630464 20:53:27 INFO - PROCESS | 21218 | 20:56:30 INFO - PROCESS | 21218 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-yui.html (next: http://localhost:49488/tests/dromaeo/cssquery-dojo.html) 20:56:30 INFO - PROCESS | 21218 | RSS: Main: 280969216 20:56:30 INFO - PROCESS | 21218 | 20:56:30 INFO - PROCESS | 21218 | __start_tp_report 20:56:30 INFO - PROCESS | 21218 | _x_x_mozilla_page_load 20:56:30 INFO - PROCESS | 21218 | _x_x_mozilla_page_load_details 20:56:30 INFO - PROCESS | 21218 | |i|pagename|runs| 20:56:30 INFO - PROCESS | 21218 | |0;dojo.html;2586.61200819877;2593.442409881875;2622.7508386703257;2629.6449979252807;2634.4335967766924;4473.865784026484;4541.114482675879;4624.583787459128;4653.557911998359;4654.999999999995;4573.3825933498965;4587.747673877935;4612.700174488664;4677.766111694419;4743.4545027321865;4336.588024137702;4358.302671572549;4378.08060307335;4396.868093957187;4421.115776844628;4315.848945286915;4381.255186618282;4403.075354175611;4425.048614547872;4468.173387923244;4407;4451.243288640922;4470.910581788362;4476.9776151119195;4495.43807024122;4189.560096189886;4240.406343111967;4356.324769660708;4379.43067401239;4407.955920440819;4301.698881078326;4304.526502084768;4310.676699247538;4318.157959197958;4340.696151269412;4715.3634259374885;4719.433667959866;4745.738984355859;4759.071980963713;4767.666263361566;4796.760161991921;5035.320231768701;5103.362079740033;5104.3619547556555;5106.897862042739;5101.387833459971;5105.387353517602;5130.743462826844;5136.203888397305;5187.247849061865;4720.197566413718;4735.905281894377;4767.976160119178;4770.379850619397;4778.5699287064335;4884.926726099111;5073.289739436482;5131.435542090367;5142.100132476801;5145.665531740499;5019.096562618691;5037.496250374933;5040.873978150576;5042.369703787027;5063.0380227756605;4847.515248475124;5076.466970968069;5081.9745901271;5084.186530155157;5113.8721531961255;4839.41926968759;4909.631777616693;4911.508849115131;4927.162382395001;4929.9014019720125;4896.95103048972;4906.067847109038;4912.140375434285;4913.287573301851;4964.503549645079;4051.4125451809323;4107.54816970133;4167.458230430086;4171.478565179353;4217.072244106292;3697.926041479155;3750.924981500409;3758.1544152565452;3771.6228377162065;3772.320982223226;4305.784710764512;4319.524852266248;4323.308270676676;4328.069465065026;4373.737575745466;4781.306710527024;4974.452810190876;5118.462561431071;5119.488051194925;5160.045391602565;4225.281702110648;4258;4273.658107351404;4303.935440968388;4305.246581848164;4441.733495990251;4470.977645111819;4481.708688935209;4481.731096134243;4522.186006518792;4524.819007239806;4726.291056341439;4754.857354279308;4764.475907650225;4813.614910807197;4963.801447942186;4966.503349665005;4966.801327946841;4975.179095449211;5002.149634562206;4731.810727570859;4738.597219236403;4778.856634300976;4785.976070119627;4823.6382271329085;4811.230203167616;4942.6293028023765;4963.181075122564;4985.326980857538;4993.27597498368;5057.241413787961;5057.8735531612;5070.4929507049;5082.872928176826;5112.412072611549;4893.9021219576125;4904.141775189399;4912.877178070434;4918.409790825124;4970.8260210893895;4751.334813126235;4795.20879054952;4807.78364973584;4849.078675051729;4866.026794641015;4744.098621261949;4760;4777.3072904429355;4804.06320767447;4809.711417314972;4766.880827979328;4858.416989961227;4871.196252618278;4872.537108974641;4915.483874193158;4588.862334129982;4651.5813576778255;4756.120117778222;4771.308160316804;4828.975855120702 20:56:30 INFO - PROCESS | 21218 | |1;ext.html;573.9540836733062;574.6839238418869;582.8659408336085;583.0903790087463;587.576944599888;37581.624183758155;39704.00739981498;39804.40293395598;44226.55773442265;44236;41728.79135604325;41831.58168418315;42009.7899510502;42514.57485425145;42530.787346063305;7750.108737495189;7897.210278972086;7897.5656338901335;7900.960495197516;7912.169222231669;7854.489458185229;7933.16701746317;7938.325242354378;7943.880841787378;7952;7976.481528700645;8007.1992800720045;8007.559584222895;8010.038795344567;8012.799680007988;7933.761987140395;7938.6427610757655;7952.363810895173;7977.24216199463;7987.640556174986;7927.960360198162;7968.681252749883;7968.920310796876;7970.601469926481;7987.161348058428;39899.20201595952;40216.396754048714;40272.395914061315;40335.596644033474;40346.19307613831;3116.501359782424;3192.4892017277125;3255.430299697567;3313.4698448248405;3336.6496517865517;28247.435051299064;30295.394092118255;30442.54336184959;30883.536746948816;31538;3499.8075105869166;3556.751027428081;3599.5500562429697;3609.981950090259;3611.368010598161;259561;260150;260419;260443.6977815118;261445;53694.19458708123;53817;54071;54116.188257176174;54127.458725412245;35401;36276.63723362785;36312.636873631454;36344.45483317752;56227.71886140543;14294.213818239888;14309.141451512942;14310;14328.928355358365;14330.856691432953;12049.759004820029;12139.150259481752;12154.635360939186;12162.939185304194;12177.452014659362;18680.81319186818;18848.34030808915;18885.339013134475;18899.338523151622;18985.240590376507;6756.797296081126;6825.385715285648;6923.134608173978;6935.791926242221;6940.7917762467205;782.3428320210936;839.8194388206565;862.4437237981467;897.4435849773182;964.4502633498979;28640.424776637487;28650.283742906595;28757.85621071881;28851.85574072158;29628.555571666442;869.0831173112427;958.912302386315;974.2206235011962;978.4373984958677;1006.3659894266565;14926.626834329229;15099.924500377429;15291.541253762405;15535.766963495556;15641.687166256612;381673;382241;385585;387366;387379;50293.24560131601;50965.74517127465;50986.74506627443;50990.745046275275;51002;1076.6016573867562;1120.4117838135044;1132.524339777279;1178.6935396796894;1205.8914697677076;27134.321641959108;30234.2441438957;30248;30932.53601196029;30982.22544436317;43904;47461.762691186326;48899.51100488949;48955.510444895095;54445.45554544404;359577;366483;367709;368510;369276;33377;38206.235875282895;38955;39840.80079599699;40564.79717601511;39522;39633.2073358537;43148.78425607852;43726;43765;35372;37553;37833.62166378411;37947.81026094852;38418.42372364361;36960;37262.627373727;37703.62296377111;37940.43089353607;38080.80959595184;36886.63113368832;37363;37857.62142378651;38028;38056.80971595124;32669.509957351132;33311.83344083264;34042.31915361728;34149.658503415645;34202.82898585491;25634.871825640752;25793.484130317665;25947.481050379265;26001.219963401127;26442.735572644797 20:56:30 INFO - PROCESS | 21218 | |2;jquery.html;367.5754503548401;370.2428533648689;373.55173791450255;380.31922858084033;381.95989421110784;16261.674766504677;16740.83259167408;17707.822921770778;17708.911455442703;17709.380171693992;16079.83920160798;16907.49277521673;16960.74558881618;17028.744568831447;17084.743728844078;4992.525710057548;5171.689698618095;5207.739613019353;5209.244659524366;5209.479052094798;3771.113788259757;3950.6444420002194;5010.899782004358;5792.623479473821;6117.051856962155;6140.171076904628;6170.321264660884;6195.969020154893;6198.070289456573;6202.255729312466;5818.6217895836635;6004.549658775566;6008.48927841134;6009.669468179249;6026.517878569726;3346.1634591352163;4970.353853998957;5266.078436273637;5294.841154765363;5297.443768404339;21166.470838229012;21535.892320538453;21588.568228635497;21721.782782172133;21727.34817955464;1941.6019715958196;1942.0969249299144;1947.5692551662676;2009.4373575398765;2033.6034473277716;13153.73692526144;13255.933720331434;13305.135166214164;13311.134776239513;13790.448382064706;1644.4244514419977;1683.991580042092;1686.3928985565187;1705.4883534939593;1719.1833878907544;67862;68097;68638.65680671565;68891.31108688899;69156.6542167286;9339.346245762732;9369.344145909721;9663.565139568736;9675.951620241854;9876.5678976548;13186.142900711615;13291.534796282083;13303.201807891557;13305.467781288833;13312.400941957636;7481.8877716834295;7551.320381165611;7560.58416787071;7678;7702.114256860421;7258.745943891939;7357.374623156985;7397.445191610651;7447.85104297911;7481.7755467336065;5942.821715348547;6107.524737668588;6111.236095488064;6143.416375444325;6238.844028899314;1613.4191690991233;1700.7363858601936;1701.528178125912;1749.9300027998738;1775.1834156288253;767.7773445700684;848.5714714069355;852.7782776478036;920.7513971227731;974.3325821812082;17190.656186876193;18326.908365458086;19019.61960760777;19052.33316833932;19218;870.6082262981683;888.5290795878195;912.4114945860016;937.8452555328431;964.3153361113548;10148.340357876714;10420.47897605132;10533.578656853793;10554.841677374845;10577.576896924036;311295;401955;404138;404464;405741;85969;86672.13327866766;88079;89194.55402723074;89234.55382723045;916.5005072235648;934.6588495199203;953.2278854128178;954.174638937328;969.1568335548118;16248.675026499168;16250.756238656193;16394;16433.58916027061;16451.67096658036;36499.27001459903;36569.45145822868;40107.59892401039;41691;42534.361984570874;54238.457615423344;55133.72433137969;56360.436395635516;56781.71609141928;56874.14688779754;7468.253174682705;7770.766876993699;7872.448928574945;7887.9605601971625;8161.714339998071;11719.648410547697;12321.260724356567;12376;12640.367981601066;12650.936745316214;10254.794904101727;10658.680239592824;10668.413237272025;10751.354918704903;10937.343759374464;10490.790184196121;10671.839922401015;10714.517846697074;10752.35485870819;10899.945500272448;10888.836667450152;10922.453877305945;11166.832497512707;11183.608573700207;11207.327560346404;7835;7871.33093687043;8020.478668886503;8083.9191608083165;8299.543525106177;10291.382517049002;10828.891711082788;10895.237333386587;10949.343039417661;11094.223404361617 20:56:30 INFO - PROCESS | 21218 | |3;mootools.html;1320.194681244441;1382.6128683968489;1426.985730142699;1667.6664667066589;1690.9830901690987;7466.216047315035;7870.134285228621;7889.881651775214;7913.406494512906;7937.365010799137;6557.114789503427;7390.224026477224;7625.0849898012175;7638.427117966147;7822;2180.258712037903;2208.845380823343;2209.0942713487475;2210.35899589119;2213.391317387723;1821.1713670280058;1897.3643829317127;2142;2157.9028943697494;2201.38361258847;1918.8944608046552;2143.9892800535977;2211.635080211763;2213.734351877777;2227.3986023773573;2139.3047259640603;2140.4862832920066;2143.506993391513;2143.528423746773;2155.1810312081307;1764.9029303388309;2065.8037486438766;2070.3685375960326;2075.740532433446;2098.979010209909;6806.76176333826;6966.860662786716;7446.739364122284;7666;7689.154193038761;4637.327587499827;4785.473597904228;4788.688735232199;4788.688735232234;4789.616830653539;2822.7459528642316;2824.9852036426328;2837.0495883878925;2845.8616553378606;2853.529167687329;888.3692578269437;894.5080205886736;908.8227795579865;922.1792604581927;925.0841666749936;10068.848967265423;10114.9885011499;10132;10175.643852465202;10237.9488102559;3957.9010524737114;4044.8584299549375;4213.304804707189;4230.492340919048;4246.511651160156;8638.913610863936;8727.694530691395;8739.12608739121;8764.29096326223;8770.38607297483;4669.41632295963;4675.392199014174;4682.016776476978;4691.695039822401;4698.55363740451;4227.957720422818;4265.3601959705675;4298.871033868989;4299.441072660534;4300.548442413564;3582.2656355447593;3603.387424137903;3603.5315408997185;3631.94552081719;3700.259948010355;1070.4968664727567;1073.3988966178808;1090.7872964771793;1091.345192884279;1137.0960086731068;695.0824911117378;722.6567380494223;732.5385007445382;844.966201351939;882.4705176893813;5160.690358578498;5346.652467589594;5364.946350536523;5541.947030064275;5556.388797232301;874.4971641306274;875.0287181228831;884.1158841158841;889.208604342136;915.2952226785338;3527.5943266524164;3587.1032241939515;3656.725745569093;3684.797336146484;3719.75821571597;9587.472689002172;9789.608415663437;9876.259280553988;9955.55200016001;9966.2525310602;8130.065042520067;9091.772705682411;9492.145706886413;9857.162141218078;9878.061584149495;7351;7524.962375188198;7535.585542795199;7536.886946695804;7543.207963163899;5473.06957817164;5489.1217405214975;5507.063799154073;5570.470805273492;5595.244641973444;9033.638654453749;9052.637894484147;9065.274778017874;9066.682666106655;9096.499692516974;8860.601272942604;8935.776605584653;9190;9255.35212535143;9265.44407335562;6228.968855155696;6286.874262514632;6300.905486417799;6367.713452894538;6448.258450278278;7273.309035641606;7287.307705767944;7302.306280903305;7325.157606875277;7334.449916256409;6451.774187903401;6601.669916504059;6665.066890635412;6677.666116694243;6679.76620818269;6450.870982580416;6603.80188594343;6656.73373065072;6715.5299129060495;6958.338957799001;6601.768938087336;6644.036614690746;6656.7670131545165;6666.333366663489;6669.199696036507;4445.955540444555;4451.376807246923;4540.772961351985;4619.683390233768;4650.534946505322;4380.934285985776;4404.185225733249;4471.485779135311;4486.528914464065;4491.752953587454 20:56:30 INFO - PROCESS | 21218 | |4;prototype.html;304.95883055787465;306.86191213953714;310.5853685330084;310.60863312226587;311.1490074645845;4832.83085092021;4839.4918533554;4840.588549973252;4857.271409288608;4860.829870954517;4791.952080479195;4796.376471058767;4811.494793046732;4837.467878533358;4842.66101372904;3639.1448009717697;3717.275131349388;3737.588865224823;3840.3855383138703;3872.2642697887454;3805.1248212911046;3806.7335286529956;3809.371453710148;3837.0239326746746;3848.903777405559;3584.623614520477;3752.5684546277116;3764.1906989997146;3775.207206486641;3788.495641531586;3659.4876717259604;3780.0738818989525;3785.9242815143816;3796;3808.3525800613825;3319.170207448138;3334.1331253873923;3346.1300061983816;3355.966440335614;3380.7126394256516;4687.601553867926;4715.528447155291;4722.645801564897;4723;4736.171170045228;4226.949929284295;4297.699161058727;4304.460368382669;4335.263005289108;4351.651867850596;4958.801647934079;4960.107180707471;4968.503149685039;4987.728129327034;4997.50024997501;3652.8721494747824;3666.633336666339;3671.7429779915415;3682.3187710273687;3684.778913265186;5126.641135120543;5154.484551544853;5194.246834209019;5235.921461178085;5252.553532949704;3721.3859713147026;3730.962690373116;3734.79458629778;3743.5320584926885;3777.867774627875;3808.980955095207;3812.9877396856173;3823.388257878726;3832.5017747693178;3836.5204349456317;4286.421333119989;4295.52749197588;4306.354046892991;4314.9784251078545;4315.4605674290715;4883.682560633548;4968.080905032581;4979.05816731475;4981.975090124526;5002.1496345621335;1291.109134697056;1296.1380681846656;1303.8305020347293;1305.556110922291;1310.351376068833;859.458541119091;868.8479516084786;904.1997831918668;932.3566738950103;935.1863878425813;4308.655307575386;4317.287647538121;4323.178596066738;4326.372675961968;4331.848385306499;5056.6713163644245;5067.569256613156;5070.011347787146;5083.110455670317;5099.56653684441;4134.400511925754;4313;4335.609795118391;4338.349247612883;4341.6526677865695;2708.2552298118176;2711.8508482033676;2722.1561315992108;2726.7273272672574;2732.194002769188;4789.3294938708605;4847.491013443538;4853.102176097434;4856.271559266138;4870.732109733928;5005.799768009311;5133.305014867225;5168.8449346519665;5173.741312934339;5357.223202635596;4877.12211801879;4883.487233840467;4902;4905.681130726492;4906.9263961040615;5133.358330208724;5156.871078223075;5182.352205974254;5184;5198.558122559473;4790.9281360780315;5110.9233361500355;5121.61587880903;5126.487351264844;5126.871828204325;4891.682040667345;4892.828750993841;4915.11527924977;4915.557599816034;4919.163742163769;3672.8163591819766;3704.9444258336684;3710.109573702346;3714.7213958953726;3734.3651579232137;4964.032013757283;5213.426523082534;5225.790968361223;5234.712090835041;5262.605304602093;5001.549860512571;5028.195488721787;5034.496550344937;5038.874028149326;5041.722705251246;4997.425296090851;5000.2999580058095;5004.874878128076;5059.544640982329;5061.848144555669;4724.267738500538;4776.713397196179;4958.38852372973;4994.527708784175;5027.49725027509;4917.705137557917;4983.800647974041;5050.570701490415;5056.595472362129;5073.873153171053;4941.258811178352;4953.851384458472;4962.230854217602;4968.956519131023;4970.726610036482 20:56:30 INFO - PROCESS | 21218 | |5;yui.html;594.5184400635486;605.2041565341575;652.8694261147768;666.4135560706579;668.5387082912792;13716.657083572916;14434.5669629911;14444.783328250085;14455.999999999987;14467.638309042266;14994.250287485636;15240.466583669573;15241.237938103079;15244.771328430055;15261.923690381533;701.2216439751884;786.3944762532847;788.3141666749935;789.2541548236918;790.2137373313561;784.2588753627824;794.3327604811957;794.4041968523608;794.4677066365549;794.9284564389204;837.660747397305;840.2353857989231;842.2461896602537;842.9114942930966;844.1937949258444;834.862247729124;836.7364280251732;837.0750320895414;837.5686521441462;838.1409055717877;609.3327806052409;610.0879185617486;613.5827637206697;613.6594190224424;614.8370681769335;13802.930985345009;13804;13843.515476958259;13847.376868040963;13850.09974351674;12634.74730505394;12775.808362874564;13080.738385232336;13082.934585327108;13247.337633118403;10765.33137363702;10835.783284334348;10916.235863489559;10931.836022459669;11118.388488633122;3295.6374798772117;3296.653851345598;3326.8170250636203;3374.6456622054575;3483.198864261234;44412.55587444117;47498.28752568714;57786.99999999958;57830.42169578335;62128.37871621271;9781.46201958885;10055.44695041765;10208.591656333812;10239.232057595562;10250;19862.90068549648;19990.90004549968;20284.695729564068;20303.695444568344;20334.186632534827;6810.114685091005;7026.543274687231;7042.647867606599;7189.317014883578;7255.8911616325795;3753.49327840738;3784.8675296364495;3826.6747326477002;3861.864834730771;3939.881803545898;2796.6644002719804;2917.9708202918123;2918.1537354167476;2918.73731364174;2921.5033444314518;494.90844193824256;499.3209235439799;513.5352505982092;515.2554558662696;522.4984015345235;571.5284889965795;598.6767145741338;610.8625559249133;614.7110857896781;625.1060982794647;7803.297703206738;7881.724139655084;8012.559309238048;8220.753377398687;8290.8341833163;559.9412061733459;564.0101621653971;573.6902072880681;593.1073734030257;598.5510866849862;3842.6733727633464;3858.4855718809063;3915.451836742858;3997.160596274815;4011.217812526529;54852;56221.71889140528;72200.63899680573;100252;100312.49843750881;58889.41110588925;73259.63370183115;86634.56682716546;88930.11069889218;91938.54030729804;75807;77682;79271;79555.60222198852;79965.85285957494;7972.601369931364;8090.474119182234;8121.675132994614;8144.877826832484;8425.43921012129;45670.771646141555;46065.76967115143;46086.769566151954;46260.76869615765;46604.7669761649;62445.68777156085;68342.31657683359;68675.31324686689;68809.65595171992;68916.31083689099;11348.54605815758;11506.712332191762;11535.134864885;11733.413329333669;11932.821007684717;12380.752384952431;12516.123871329284;12543.3101179436;12670.683232919251;13068.21846179808;11871.940640296743;12145.149839511503;12228.205166664138;12251;12403.93798031004;10702;11193.160512961398;11280.830787538358;11498.48256828428;11572.305661660328;11737.589184378507;11745.060395168195;11887.940560297144;11957.940210298893;11958.64124076279;10347.541567872317;10426.739331516772;10676.306040107369;10908.727281818017;11316.20786544934;9997.900020999698;10164.971006458076;10522.263441559018;10548.367097974146;10577.418241996764 20:56:30 INFO - PROCESS | 21218 | __end_tp_report 20:56:30 INFO - PROCESS | 21218 | __start_cc_report 20:56:30 INFO - PROCESS | 21218 | _x_x_mozilla_cycle_collect,1064 20:56:30 INFO - PROCESS | 21218 | __end_cc_report 20:56:30 INFO - PROCESS | 21218 | __startTimestamp1468986990494__endTimestamp 20:56:30 INFO - PROCESS | 21218 | 20:56:30 INFO - PROCESS | 21218 | ------- Summary: start ------- 20:56:30 INFO - PROCESS | 21218 | Number of tests: 6 20:56:30 INFO - PROCESS | 21218 | 20:56:30 INFO - PROCESS | 21218 | [#0] dojo.html Cycles:165 Average:4633.96 Median:4764.48 stddev:484.87 (10.2%) stddev-sans-first:458.99 20:56:30 INFO - PROCESS | 21218 | Values: 2586.6 2593.4 2622.8 2629.6 2634.4 4473.9 4541.1 4624.6 4653.6 4655.0 4573.4 4587.7 4612.7 4677.8 4743.5 4336.6 4358.3 4378.1 4396.9 4421.1 4315.8 4381.3 4403.1 4425.0 4468.2 4407.0 4451.2 4470.9 4477.0 4495.4 4189.6 4240.4 4356.3 4379.4 4408.0 4301.7 4304.5 4310.7 4318.2 4340.7 4715.4 4719.4 4745.7 4759.1 4767.7 4796.8 5035.3 5103.4 5104.4 5106.9 5101.4 5105.4 5130.7 5136.2 5187.2 4720.2 4735.9 4768.0 4770.4 4778.6 4884.9 5073.3 5131.4 5142.1 5145.7 5019.1 5037.5 5040.9 5042.4 5063.0 4847.5 5076.5 5082.0 5084.2 5113.9 4839.4 4909.6 4911.5 4927.2 4929.9 4897.0 4906.1 4912.1 4913.3 4964.5 4051.4 4107.5 4167.5 4171.5 4217.1 3697.9 3750.9 3758.2 3771.6 3772.3 4305.8 4319.5 4323.3 4328.1 4373.7 4781.3 4974.5 5118.5 5119.5 5160.0 4225.3 4258.0 4273.7 4303.9 4305.2 4441.7 4471.0 4481.7 4481.7 4522.2 4524.8 4726.3 4754.9 4764.5 4813.6 4963.8 4966.5 4966.8 4975.2 5002.1 4731.8 4738.6 4778.9 4786.0 4823.6 4811.2 4942.6 4963.2 4985.3 4993.3 5057.2 5057.9 5070.5 5082.9 5112.4 4893.9 4904.1 4912.9 4918.4 4970.8 4751.3 4795.2 4807.8 4849.1 4866.0 4744.1 4760.0 4777.3 4804.1 4809.7 4766.9 4858.4 4871.2 4872.5 4915.5 4588.9 4651.6 4756.1 4771.3 4829.0 20:56:30 INFO - PROCESS | 21218 | 20:56:30 INFO - PROCESS | 21218 | [#1] ext.html Cycles:180 Average:49660.54 Median:209876.90 stddev:89884.71 (42.8%) stddev-sans-first:90061.30 20:56:30 INFO - PROCESS | 21218 | Values: 574.0 574.7 582.9 583.1 587.6 37581.6 39704.0 39804.4 44226.6 44236.0 41728.8 41831.6 42009.8 42514.6 42530.8 7750.1 7897.2 7897.6 7901.0 7912.2 7854.5 7933.2 7938.3 7943.9 7952.0 7976.5 8007.2 8007.6 8010.0 8012.8 7933.8 7938.6 7952.4 7977.2 7987.6 7928.0 7968.7 7968.9 7970.6 7987.2 39899.2 40216.4 40272.4 40335.6 40346.2 3116.5 3192.5 3255.4 3313.5 3336.6 28247.4 30295.4 30442.5 30883.5 31538.0 3499.8 3556.8 3599.6 3610.0 3611.4 259561.0 260150.0 260419.0 260443.7 261445.0 53694.2 53817.0 54071.0 54116.2 54127.5 35401.0 36276.6 36312.6 36344.5 56227.7 14294.2 14309.1 14310.0 14328.9 14330.9 12049.8 12139.2 12154.6 12162.9 12177.5 18680.8 18848.3 18885.3 18899.3 18985.2 6756.8 6825.4 6923.1 6935.8 6940.8 782.3 839.8 862.4 897.4 964.5 28640.4 28650.3 28757.9 28851.9 29628.6 869.1 958.9 974.2 978.4 1006.4 14926.6 15099.9 15291.5 15535.8 15641.7 381673.0 382241.0 385585.0 387366.0 387379.0 50293.2 50965.7 50986.7 50990.7 51002.0 1076.6 1120.4 1132.5 1178.7 1205.9 27134.3 30234.2 30248.0 30932.5 30982.2 43904.0 47461.8 48899.5 48955.5 54445.5 359577.0 366483.0 367709.0 368510.0 369276.0 33377.0 38206.2 38955.0 39840.8 40564.8 39522.0 39633.2 43148.8 43726.0 43765.0 35372.0 37553.0 37833.6 37947.8 38418.4 36960.0 37262.6 37703.6 37940.4 38080.8 36886.6 37363.0 37857.6 38028.0 38056.8 32669.5 33311.8 34042.3 34149.7 34202.8 25634.9 25793.5 25947.5 26001.2 26442.7 20:56:30 INFO - PROCESS | 21218 | 20:56:30 INFO - PROCESS | 21218 | [#2] jquery.html Cycles:180 Average:25069.52 Median:22029.12 stddev:64242.32 (291.6%) stddev-sans-first:64395.76 20:56:30 INFO - PROCESS | 21218 | Values: 367.6 370.2 373.6 380.3 382.0 16261.7 16740.8 17707.8 17708.9 17709.4 16079.8 16907.5 16960.7 17028.7 17084.7 4992.5 5171.7 5207.7 5209.2 5209.5 3771.1 3950.6 5010.9 5792.6 6117.1 6140.2 6170.3 6196.0 6198.1 6202.3 5818.6 6004.5 6008.5 6009.7 6026.5 3346.2 4970.4 5266.1 5294.8 5297.4 21166.5 21535.9 21588.6 21721.8 21727.3 1941.6 1942.1 1947.6 2009.4 2033.6 13153.7 13255.9 13305.1 13311.1 13790.4 1644.4 1684.0 1686.4 1705.5 1719.2 67862.0 68097.0 68638.7 68891.3 69156.7 9339.3 9369.3 9663.6 9676.0 9876.6 13186.1 13291.5 13303.2 13305.5 13312.4 7481.9 7551.3 7560.6 7678.0 7702.1 7258.7 7357.4 7397.4 7447.9 7481.8 5942.8 6107.5 6111.2 6143.4 6238.8 1613.4 1700.7 1701.5 1749.9 1775.2 767.8 848.6 852.8 920.8 974.3 17190.7 18326.9 19019.6 19052.3 19218.0 870.6 888.5 912.4 937.8 964.3 10148.3 10420.5 10533.6 10554.8 10577.6 311295.0 401955.0 404138.0 404464.0 405741.0 85969.0 86672.1 88079.0 89194.6 89234.6 916.5 934.7 953.2 954.2 969.2 16248.7 16250.8 16394.0 16433.6 16451.7 36499.3 36569.5 40107.6 41691.0 42534.4 54238.5 55133.7 56360.4 56781.7 56874.1 7468.3 7770.8 7872.4 7888.0 8161.7 11719.6 12321.3 12376.0 12640.4 12650.9 10254.8 10658.7 10668.4 10751.4 10937.3 10490.8 10671.8 10714.5 10752.4 10899.9 10888.8 10922.5 11166.8 11183.6 11207.3 7835.0 7871.3 8020.5 8083.9 8299.5 10291.4 10828.9 10895.2 10949.3 11094.2 20:56:30 INFO - PROCESS | 21218 | 20:56:30 INFO - PROCESS | 21218 | [#3] mootools.html Cycles:180 Average:5092.95 Median:5524.51 stddev:2838.02 (51.4%) stddev-sans-first:2831.82 20:56:30 INFO - PROCESS | 21218 | Values: 1320.2 1382.6 1427.0 1667.7 1691.0 7466.2 7870.1 7889.9 7913.4 7937.4 6557.1 7390.2 7625.1 7638.4 7822.0 2180.3 2208.8 2209.1 2210.4 2213.4 1821.2 1897.4 2142.0 2157.9 2201.4 1918.9 2144.0 2211.6 2213.7 2227.4 2139.3 2140.5 2143.5 2143.5 2155.2 1764.9 2065.8 2070.4 2075.7 2099.0 6806.8 6966.9 7446.7 7666.0 7689.2 4637.3 4785.5 4788.7 4788.7 4789.6 2822.7 2825.0 2837.0 2845.9 2853.5 888.4 894.5 908.8 922.2 925.1 10068.8 10115.0 10132.0 10175.6 10237.9 3957.9 4044.9 4213.3 4230.5 4246.5 8638.9 8727.7 8739.1 8764.3 8770.4 4669.4 4675.4 4682.0 4691.7 4698.6 4228.0 4265.4 4298.9 4299.4 4300.5 3582.3 3603.4 3603.5 3631.9 3700.3 1070.5 1073.4 1090.8 1091.3 1137.1 695.1 722.7 732.5 845.0 882.5 5160.7 5346.7 5364.9 5541.9 5556.4 874.5 875.0 884.1 889.2 915.3 3527.6 3587.1 3656.7 3684.8 3719.8 9587.5 9789.6 9876.3 9955.6 9966.3 8130.1 9091.8 9492.1 9857.2 9878.1 7351.0 7525.0 7535.6 7536.9 7543.2 5473.1 5489.1 5507.1 5570.5 5595.2 9033.6 9052.6 9065.3 9066.7 9096.5 8860.6 8935.8 9190.0 9255.4 9265.4 6229.0 6286.9 6300.9 6367.7 6448.3 7273.3 7287.3 7302.3 7325.2 7334.4 6451.8 6601.7 6665.1 6677.7 6679.8 6450.9 6603.8 6656.7 6715.5 6958.3 6601.8 6644.0 6656.8 6666.3 6669.2 4446.0 4451.4 4540.8 4619.7 4650.5 4380.9 4404.2 4471.5 4486.5 4491.8 20:56:30 INFO - PROCESS | 21218 | 20:56:30 INFO - PROCESS | 21218 | [#4] prototype.html Cycles:180 Average:4182.07 Median:4803.94 stddev:1195.40 (24.9%) stddev-sans-first:1162.79 20:56:30 INFO - PROCESS | 21218 | Values: 305.0 306.9 310.6 310.6 311.1 4832.8 4839.5 4840.6 4857.3 4860.8 4792.0 4796.4 4811.5 4837.5 4842.7 3639.1 3717.3 3737.6 3840.4 3872.3 3805.1 3806.7 3809.4 3837.0 3848.9 3584.6 3752.6 3764.2 3775.2 3788.5 3659.5 3780.1 3785.9 3796.0 3808.4 3319.2 3334.1 3346.1 3356.0 3380.7 4687.6 4715.5 4722.6 4723.0 4736.2 4226.9 4297.7 4304.5 4335.3 4351.7 4958.8 4960.1 4968.5 4987.7 4997.5 3652.9 3666.6 3671.7 3682.3 3684.8 5126.6 5154.5 5194.2 5235.9 5252.6 3721.4 3731.0 3734.8 3743.5 3777.9 3809.0 3813.0 3823.4 3832.5 3836.5 4286.4 4295.5 4306.4 4315.0 4315.5 4883.7 4968.1 4979.1 4982.0 5002.1 1291.1 1296.1 1303.8 1305.6 1310.4 859.5 868.8 904.2 932.4 935.2 4308.7 4317.3 4323.2 4326.4 4331.8 5056.7 5067.6 5070.0 5083.1 5099.6 4134.4 4313.0 4335.6 4338.3 4341.7 2708.3 2711.9 2722.2 2726.7 2732.2 4789.3 4847.5 4853.1 4856.3 4870.7 5005.8 5133.3 5168.8 5173.7 5357.2 4877.1 4883.5 4902.0 4905.7 4906.9 5133.4 5156.9 5182.4 5184.0 5198.6 4790.9 5110.9 5121.6 5126.5 5126.9 4891.7 4892.8 4915.1 4915.6 4919.2 3672.8 3704.9 3710.1 3714.7 3734.4 4964.0 5213.4 5225.8 5234.7 5262.6 5001.5 5028.2 5034.5 5038.9 5041.7 4997.4 5000.3 5004.9 5059.5 5061.8 4724.3 4776.7 4958.4 4994.5 5027.5 4917.7 4983.8 5050.6 5056.6 5073.9 4941.3 4953.9 4962.2 4969.0 4970.7 20:56:30 INFO - PROCESS | 21218 | 20:56:30 INFO - PROCESS | 21218 | [#5] yui.html Cycles:180 Average:17339.22 Median:45041.66 stddev:23872.37 (53.0%) stddev-sans-first:23906.23 20:56:30 INFO - PROCESS | 21218 | Values: 594.5 605.2 652.9 666.4 668.5 13716.7 14434.6 14444.8 14456.0 14467.6 14994.3 15240.5 15241.2 15244.8 15261.9 701.2 786.4 788.3 789.3 790.2 784.3 794.3 794.4 794.5 794.9 837.7 840.2 842.2 842.9 844.2 834.9 836.7 837.1 837.6 838.1 609.3 610.1 613.6 613.7 614.8 13802.9 13804.0 13843.5 13847.4 13850.1 12634.7 12775.8 13080.7 13082.9 13247.3 10765.3 10835.8 10916.2 10931.8 11118.4 3295.6 3296.7 3326.8 3374.6 3483.2 44412.6 47498.3 57787.0 57830.4 62128.4 9781.5 10055.4 10208.6 10239.2 10250.0 19862.9 19990.9 20284.7 20303.7 20334.2 6810.1 7026.5 7042.6 7189.3 7255.9 3753.5 3784.9 3826.7 3861.9 3939.9 2796.7 2918.0 2918.2 2918.7 2921.5 494.9 499.3 513.5 515.3 522.5 571.5 598.7 610.9 614.7 625.1 7803.3 7881.7 8012.6 8220.8 8290.8 559.9 564.0 573.7 593.1 598.6 3842.7 3858.5 3915.5 3997.2 4011.2 54852.0 56221.7 72200.6 100252.0 100312.5 58889.4 73259.6 86634.6 88930.1 91938.5 75807.0 77682.0 79271.0 79555.6 79965.9 7972.6 8090.5 8121.7 8144.9 8425.4 45670.8 46065.8 46086.8 46260.8 46604.8 62445.7 68342.3 68675.3 68809.7 68916.3 11348.5 11506.7 11535.1 11733.4 11932.8 12380.8 12516.1 12543.3 12670.7 13068.2 11871.9 12145.1 12228.2 12251.0 12403.9 10702.0 11193.2 11280.8 11498.5 11572.3 11737.6 11745.1 11887.9 11957.9 11958.6 10347.5 10426.7 10676.3 10908.7 11316.2 9997.9 10165.0 10522.3 10548.4 10577.4 20:56:30 INFO - PROCESS | 21218 | -------- Summary: end -------- 20:56:30 INFO - PROCESS | 21218 | 20:56:31 INFO - TEST-INFO | 21218: exit 0 20:56:31 INFO - TEST-OK | dromaeo_css | took 1120012ms 20:56:31 INFO - TEST-START | kraken 20:56:31 INFO - operating with platform_type : linux_ 20:56:31 INFO - Initialising browser for kraken test... 20:56:31 INFO - TEST-INFO | started process 21411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcw8Ml_/profile http://localhost:49488/getInfo.html) 20:56:35 INFO - PROCESS | 21411 | __metrics Screen width/height:1600/1200 20:56:35 INFO - PROCESS | 21411 | colorDepth:24 20:56:35 INFO - PROCESS | 21411 | Browser inner width/height: 1024/697 20:56:35 INFO - PROCESS | 21411 | __metrics 20:56:36 INFO - PROCESS | 21411 | 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" 20:56:36 INFO - PROCESS | 21411 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:56:37 INFO - TEST-INFO | 21411: exit 0 20:56:37 INFO - Browser initialized. 20:56:37 INFO - Running cycle 1/1 for kraken test... 20:56:37 INFO - TEST-INFO | started process 21492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcw8Ml_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:56:49 INFO - PROCESS | 21492 | RSS: Main: 159387648 20:56:49 INFO - PROCESS | 21492 | 20:56:52 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-beat-detection) 20:56:53 INFO - PROCESS | 21492 | RSS: Main: 218243072 20:56:53 INFO - PROCESS | 21492 | 20:56:55 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-dft) 20:56:56 INFO - PROCESS | 21492 | RSS: Main: 206270464 20:56:56 INFO - PROCESS | 21492 | 20:56:59 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-fft) 20:57:00 INFO - PROCESS | 21492 | RSS: Main: 271859712 20:57:00 INFO - PROCESS | 21492 | 20:57:02 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-oscillator) 20:57:03 INFO - PROCESS | 21492 | RSS: Main: 181456896 20:57:03 INFO - PROCESS | 21492 | 20:57:05 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:57:05 INFO - PROCESS | 21492 | RSS: Main: 186347520 20:57:05 INFO - PROCESS | 21492 | 20:57:09 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-darkroom) 20:57:09 INFO - PROCESS | 21492 | RSS: Main: 222101504 20:57:09 INFO - PROCESS | 21492 | 20:57:13 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-desaturate) 20:57:13 INFO - PROCESS | 21492 | RSS: Main: 217919488 20:57:13 INFO - PROCESS | 21492 | 20:57:16 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49488/tests/kraken/driver.html?testName=json-parse-financial) 20:57:17 INFO - PROCESS | 21492 | RSS: Main: 220979200 20:57:17 INFO - PROCESS | 21492 | 20:57:19 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:57:19 INFO - PROCESS | 21492 | RSS: Main: 210862080 20:57:19 INFO - PROCESS | 21492 | 20:57:21 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:57:22 INFO - PROCESS | 21492 | RSS: Main: 213995520 20:57:22 INFO - PROCESS | 21492 | 20:57:24 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:57:25 INFO - PROCESS | 21492 | RSS: Main: 212660224 20:57:25 INFO - PROCESS | 21492 | 20:57:27 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:57:28 INFO - PROCESS | 21492 | RSS: Main: 223506432 20:57:28 INFO - PROCESS | 21492 | 20:57:31 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:57:31 INFO - PROCESS | 21492 | RSS: Main: 223625216 20:57:31 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49488/tests/kraken/driver.html?testName=ai-astar) 20:57:33 INFO - PROCESS | 21492 | RSS: Main: 265662464 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | __start_tp_report 20:57:33 INFO - PROCESS | 21492 | _x_x_mozilla_page_load 20:57:33 INFO - PROCESS | 21492 | _x_x_mozilla_page_load_details 20:57:33 INFO - PROCESS | 21492 | |i|pagename|runs| 20:57:33 INFO - PROCESS | 21492 | |0;ai-astar;105;116;114;116;116;116;114;115;114;114 20:57:33 INFO - PROCESS | 21492 | |1;audio-beat-detection;145;126;126;184;128;124;153;122;189;123 20:57:33 INFO - PROCESS | 21492 | |2;audio-dft;162;164;161;161;161;161;165;161;161;164 20:57:33 INFO - PROCESS | 21492 | |3;audio-fft;76;78;78;108;77;78;75;77;100;77 20:57:33 INFO - PROCESS | 21492 | |4;audio-oscillator;85;85;109;84;87;85;121;84;84;129 20:57:33 INFO - PROCESS | 21492 | |5;imaging-gaussian-blur;118;117;118;117;118;117;117;117;118;118 20:57:33 INFO - PROCESS | 21492 | |6;imaging-darkroom;147;148;146;146;147;147;147;147;146;157 20:57:33 INFO - PROCESS | 21492 | |7;imaging-desaturate;95;95;95;96;96;96;96;96;96;95 20:57:33 INFO - PROCESS | 21492 | |8;json-parse-financial;66;63;63;62;65;64;64;64;63;63 20:57:33 INFO - PROCESS | 21492 | |9;json-stringify-tinderbox;66;67;66;66;68;66;65;65;66;66 20:57:33 INFO - PROCESS | 21492 | |10;stanford-crypto-aes;78;79;88;78;78;78;89;79;79;85 20:57:33 INFO - PROCESS | 21492 | |11;stanford-crypto-ccm;129;132;134;128;135;126;141;127;166;135 20:57:33 INFO - PROCESS | 21492 | |12;stanford-crypto-pbkdf2;164;162;161;163;165;167;163;162;162;162 20:57:33 INFO - PROCESS | 21492 | |13;stanford-crypto-sha256-iterative;67;69;69;67;66;65;66;66;64;66 20:57:33 INFO - PROCESS | 21492 | __end_tp_report 20:57:33 INFO - PROCESS | 21492 | __start_cc_report 20:57:33 INFO - PROCESS | 21492 | _x_x_mozilla_cycle_collect,1902 20:57:33 INFO - PROCESS | 21492 | __end_cc_report 20:57:33 INFO - PROCESS | 21492 | __startTimestamp1468987053890__endTimestamp 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | ------- Summary: start ------- 20:57:33 INFO - PROCESS | 21492 | Number of tests: 14 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.50 stddev:3.30 (2.9%) stddev-sans-first:1.00 20:57:33 INFO - PROCESS | 21492 | Values: 105.0 116.0 114.0 116.0 116.0 116.0 114.0 115.0 114.0 114.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:136.50 stddev:25.60 (18.8%) stddev-sans-first:27.12 20:57:33 INFO - PROCESS | 21492 | Values: 145.0 126.0 126.0 184.0 128.0 124.0 153.0 122.0 189.0 123.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#2] audio-dft Cycles:10 Average:162.10 Median:161.50 stddev:1.60 (1.0%) stddev-sans-first:1.69 20:57:33 INFO - PROCESS | 21492 | Values: 162.0 164.0 161.0 161.0 161.0 161.0 165.0 161.0 161.0 164.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:11.58 (15.0%) stddev-sans-first:12.05 20:57:33 INFO - PROCESS | 21492 | Values: 76.0 78.0 78.0 108.0 77.0 78.0 75.0 77.0 100.0 77.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.50 stddev:17.49 (20.7%) stddev-sans-first:18.15 20:57:33 INFO - PROCESS | 21492 | Values: 85.0 85.0 109.0 84.0 87.0 85.0 121.0 84.0 84.0 129.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:57:33 INFO - PROCESS | 21492 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.00 stddev:3.29 (2.2%) stddev-sans-first:3.48 20:57:33 INFO - PROCESS | 21492 | Values: 147.0 148.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 157.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:57:33 INFO - PROCESS | 21492 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:1.16 (1.8%) stddev-sans-first:0.88 20:57:33 INFO - PROCESS | 21492 | Values: 66.0 63.0 63.0 62.0 65.0 64.0 64.0 64.0 63.0 63.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 20:57:33 INFO - PROCESS | 21492 | Values: 66.0 67.0 66.0 66.0 68.0 66.0 65.0 65.0 66.0 66.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:79.00 stddev:4.43 (5.6%) stddev-sans-first:4.56 20:57:33 INFO - PROCESS | 21492 | Values: 78.0 79.0 88.0 78.0 78.0 78.0 89.0 79.0 79.0 85.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:134.50 stddev:11.72 (8.7%) stddev-sans-first:12.21 20:57:33 INFO - PROCESS | 21492 | Values: 129.0 132.0 134.0 128.0 135.0 126.0 141.0 127.0 166.0 135.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.00 stddev:1.79 (1.1%) stddev-sans-first:1.87 20:57:33 INFO - PROCESS | 21492 | Values: 164.0 162.0 161.0 163.0 165.0 167.0 163.0 162.0 162.0 162.0 20:57:33 INFO - PROCESS | 21492 | 20:57:33 INFO - PROCESS | 21492 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.58 (2.4%) stddev-sans-first:1.67 20:57:33 INFO - PROCESS | 21492 | Values: 67.0 69.0 69.0 67.0 66.0 65.0 66.0 66.0 64.0 66.0 20:57:33 INFO - PROCESS | 21492 | -------- Summary: end -------- 20:57:33 INFO - PROCESS | 21492 | 20:57:34 INFO - TEST-INFO | 21492: exit 0 20:57:34 INFO - TEST-OK | kraken | took 63633ms 20:57:34 INFO - SUITE-END | took 1183s 20:57:35 INFO - Completed test suite (00:19:43) 20:57:35 INFO - javascript benchmark 20:57:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.61200819877, 2593.442409881875, 2622.7508386703257, 2629.6449979252807, 2634.4335967766924, 4473.865784026484, 4541.114482675879, 4624.583787459128, 4653.557911998359, 4654.999999999995, 4573.3825933498965, 4587.747673877935, 4612.700174488664, 4677.766111694419, 4743.4545027321865, 4336.588024137702, 4358.302671572549, 4378.08060307335, 4396.868093957187, 4421.115776844628, 4315.848945286915, 4381.255186618282, 4403.075354175611, 4425.048614547872, 4468.173387923244, 4407.0, 4451.243288640922, 4470.910581788362, 4476.9776151119195, 4495.43807024122, 4189.560096189886, 4240.406343111967, 4356.324769660708, 4379.43067401239, 4407.955920440819, 4301.698881078326, 4304.526502084768, 4310.676699247538, 4318.157959197958, 4340.696151269412, 4715.3634259374885, 4719.433667959866, 4745.738984355859, 4759.071980963713, 4767.666263361566, 4796.760161991921, 5035.320231768701, 5103.362079740033, 5104.3619547556555, 5106.897862042739, 5101.387833459971, 5105.387353517602, 5130.743462826844, 5136.203888397305, 5187.247849061865, 4720.197566413718, 4735.905281894377, 4767.976160119178, 4770.379850619397, 4778.5699287064335, 4884.926726099111, 5073.289739436482, 5131.435542090367, 5142.100132476801, 5145.665531740499, 5019.096562618691, 5037.496250374933, 5040.873978150576, 5042.369703787027, 5063.0380227756605, 4847.515248475124, 5076.466970968069, 5081.9745901271, 5084.186530155157, 5113.8721531961255, 4839.41926968759, 4909.631777616693, 4911.508849115131, 4927.162382395001, 4929.9014019720125, 4896.95103048972, 4906.067847109038, 4912.140375434285, 4913.287573301851, 4964.503549645079, 4051.4125451809323, 4107.54816970133, 4167.458230430086, 4171.478565179353, 4217.072244106292, 3697.926041479155, 3750.924981500409, 3758.1544152565452, 3771.6228377162065, 3772.320982223226, 4305.784710764512, 4319.524852266248, 4323.308270676676, 4328.069465065026, 4373.737575745466, 4781.306710527024, 4974.452810190876, 5118.462561431071, 5119.488051194925, 5160.045391602565, 4225.281702110648, 4258.0, 4273.658107351404, 4303.935440968388, 4305.246581848164, 4441.733495990251, 4470.977645111819, 4481.708688935209, 4481.731096134243, 4522.186006518792, 4524.819007239806, 4726.291056341439, 4754.857354279308, 4764.475907650225, 4813.614910807197, 4963.801447942186, 4966.503349665005, 4966.801327946841, 4975.179095449211, 5002.149634562206, 4731.810727570859, 4738.597219236403, 4778.856634300976, 4785.976070119627, 4823.6382271329085, 4811.230203167616, 4942.6293028023765, 4963.181075122564, 4985.326980857538, 4993.27597498368, 5057.241413787961, 5057.8735531612, 5070.4929507049, 5082.872928176826, 5112.412072611549, 4893.9021219576125, 4904.141775189399, 4912.877178070434, 4918.409790825124, 4970.8260210893895, 4751.334813126235, 4795.20879054952, 4807.78364973584, 4849.078675051729, 4866.026794641015, 4744.098621261949, 4760.0, 4777.3072904429355, 4804.06320767447, 4809.711417314972, 4766.880827979328, 4858.416989961227, 4871.196252618278, 4872.537108974641, 4915.483874193158, 4588.862334129982, 4651.5813576778255, 4756.120117778222, 4771.308160316804, 4828.975855120702], "value": 4603.161552284529, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.9540836733062, 574.6839238418869, 582.8659408336085, 583.0903790087463, 587.576944599888, 37581.624183758155, 39704.00739981498, 39804.40293395598, 44226.55773442265, 44236.0, 41728.79135604325, 41831.58168418315, 42009.7899510502, 42514.57485425145, 42530.787346063305, 7750.108737495189, 7897.210278972086, 7897.5656338901335, 7900.960495197516, 7912.169222231669, 7854.489458185229, 7933.16701746317, 7938.325242354378, 7943.880841787378, 7952.0, 7976.481528700645, 8007.1992800720045, 8007.559584222895, 8010.038795344567, 8012.799680007988, 7933.761987140395, 7938.6427610757655, 7952.363810895173, 7977.24216199463, 7987.640556174986, 7927.960360198162, 7968.681252749883, 7968.920310796876, 7970.601469926481, 7987.161348058428, 39899.20201595952, 40216.396754048714, 40272.395914061315, 40335.596644033474, 40346.19307613831, 3116.501359782424, 3192.4892017277125, 3255.430299697567, 3313.4698448248405, 3336.6496517865517, 28247.435051299064, 30295.394092118255, 30442.54336184959, 30883.536746948816, 31538.0, 3499.8075105869166, 3556.751027428081, 3599.5500562429697, 3609.981950090259, 3611.368010598161, 259561.0, 260150.0, 260419.0, 260443.6977815118, 261445.0, 53694.19458708123, 53817.0, 54071.0, 54116.188257176174, 54127.458725412245, 35401.0, 36276.63723362785, 36312.636873631454, 36344.45483317752, 56227.71886140543, 14294.213818239888, 14309.141451512942, 14310.0, 14328.928355358365, 14330.856691432953, 12049.759004820029, 12139.150259481752, 12154.635360939186, 12162.939185304194, 12177.452014659362, 18680.81319186818, 18848.34030808915, 18885.339013134475, 18899.338523151622, 18985.240590376507, 6756.797296081126, 6825.385715285648, 6923.134608173978, 6935.791926242221, 6940.7917762467205, 782.3428320210936, 839.8194388206565, 862.4437237981467, 897.4435849773182, 964.4502633498979, 28640.424776637487, 28650.283742906595, 28757.85621071881, 28851.85574072158, 29628.555571666442, 869.0831173112427, 958.912302386315, 974.2206235011962, 978.4373984958677, 1006.3659894266565, 14926.626834329229, 15099.924500377429, 15291.541253762405, 15535.766963495556, 15641.687166256612, 381673.0, 382241.0, 385585.0, 387366.0, 387379.0, 50293.24560131601, 50965.74517127465, 50986.74506627443, 50990.745046275275, 51002.0, 1076.6016573867562, 1120.4117838135044, 1132.524339777279, 1178.6935396796894, 1205.8914697677076, 27134.321641959108, 30234.2441438957, 30248.0, 30932.53601196029, 30982.22544436317, 43904.0, 47461.762691186326, 48899.51100488949, 48955.510444895095, 54445.45554544404, 359577.0, 366483.0, 367709.0, 368510.0, 369276.0, 33377.0, 38206.235875282895, 38955.0, 39840.80079599699, 40564.79717601511, 39522.0, 39633.2073358537, 43148.78425607852, 43726.0, 43765.0, 35372.0, 37553.0, 37833.62166378411, 37947.81026094852, 38418.42372364361, 36960.0, 37262.627373727, 37703.62296377111, 37940.43089353607, 38080.80959595184, 36886.63113368832, 37363.0, 37857.62142378651, 38028.0, 38056.80971595124, 32669.509957351132, 33311.83344083264, 34042.31915361728, 34149.658503415645, 34202.82898585491, 25634.871825640752, 25793.484130317665, 25947.481050379265, 26001.219963401127, 26442.735572644797], "value": 18094.21692910188, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.5754503548401, 370.2428533648689, 373.55173791450255, 380.31922858084033, 381.95989421110784, 16261.674766504677, 16740.83259167408, 17707.822921770778, 17708.911455442703, 17709.380171693992, 16079.83920160798, 16907.49277521673, 16960.74558881618, 17028.744568831447, 17084.743728844078, 4992.525710057548, 5171.689698618095, 5207.739613019353, 5209.244659524366, 5209.479052094798, 3771.113788259757, 3950.6444420002194, 5010.899782004358, 5792.623479473821, 6117.051856962155, 6140.171076904628, 6170.321264660884, 6195.969020154893, 6198.070289456573, 6202.255729312466, 5818.6217895836635, 6004.549658775566, 6008.48927841134, 6009.669468179249, 6026.517878569726, 3346.1634591352163, 4970.353853998957, 5266.078436273637, 5294.841154765363, 5297.443768404339, 21166.470838229012, 21535.892320538453, 21588.568228635497, 21721.782782172133, 21727.34817955464, 1941.6019715958196, 1942.0969249299144, 1947.5692551662676, 2009.4373575398765, 2033.6034473277716, 13153.73692526144, 13255.933720331434, 13305.135166214164, 13311.134776239513, 13790.448382064706, 1644.4244514419977, 1683.991580042092, 1686.3928985565187, 1705.4883534939593, 1719.1833878907544, 67862.0, 68097.0, 68638.65680671565, 68891.31108688899, 69156.6542167286, 9339.346245762732, 9369.344145909721, 9663.565139568736, 9675.951620241854, 9876.5678976548, 13186.142900711615, 13291.534796282083, 13303.201807891557, 13305.467781288833, 13312.400941957636, 7481.8877716834295, 7551.320381165611, 7560.58416787071, 7678.0, 7702.114256860421, 7258.745943891939, 7357.374623156985, 7397.445191610651, 7447.85104297911, 7481.7755467336065, 5942.821715348547, 6107.524737668588, 6111.236095488064, 6143.416375444325, 6238.844028899314, 1613.4191690991233, 1700.7363858601936, 1701.528178125912, 1749.9300027998738, 1775.1834156288253, 767.7773445700684, 848.5714714069355, 852.7782776478036, 920.7513971227731, 974.3325821812082, 17190.656186876193, 18326.908365458086, 19019.61960760777, 19052.33316833932, 19218.0, 870.6082262981683, 888.5290795878195, 912.4114945860016, 937.8452555328431, 964.3153361113548, 10148.340357876714, 10420.47897605132, 10533.578656853793, 10554.841677374845, 10577.576896924036, 311295.0, 401955.0, 404138.0, 404464.0, 405741.0, 85969.0, 86672.13327866766, 88079.0, 89194.55402723074, 89234.55382723045, 916.5005072235648, 934.6588495199203, 953.2278854128178, 954.174638937328, 969.1568335548118, 16248.675026499168, 16250.756238656193, 16394.0, 16433.58916027061, 16451.67096658036, 36499.27001459903, 36569.45145822868, 40107.59892401039, 41691.0, 42534.361984570874, 54238.457615423344, 55133.72433137969, 56360.436395635516, 56781.71609141928, 56874.14688779754, 7468.253174682705, 7770.766876993699, 7872.448928574945, 7887.9605601971625, 8161.714339998071, 11719.648410547697, 12321.260724356567, 12376.0, 12640.367981601066, 12650.936745316214, 10254.794904101727, 10658.680239592824, 10668.413237272025, 10751.354918704903, 10937.343759374464, 10490.790184196121, 10671.839922401015, 10714.517846697074, 10752.35485870819, 10899.945500272448, 10888.836667450152, 10922.453877305945, 11166.832497512707, 11183.608573700207, 11207.327560346404, 7835.0, 7871.33093687043, 8020.478668886503, 8083.9191608083165, 8299.543525106177, 10291.382517049002, 10828.891711082788, 10895.237333386587, 10949.343039417661, 11094.223404361617], "value": 8611.557628331399, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.194681244441, 1382.6128683968489, 1426.985730142699, 1667.6664667066589, 1690.9830901690987, 7466.216047315035, 7870.134285228621, 7889.881651775214, 7913.406494512906, 7937.365010799137, 6557.114789503427, 7390.224026477224, 7625.0849898012175, 7638.427117966147, 7822.0, 2180.258712037903, 2208.845380823343, 2209.0942713487475, 2210.35899589119, 2213.391317387723, 1821.1713670280058, 1897.3643829317127, 2142.0, 2157.9028943697494, 2201.38361258847, 1918.8944608046552, 2143.9892800535977, 2211.635080211763, 2213.734351877777, 2227.3986023773573, 2139.3047259640603, 2140.4862832920066, 2143.506993391513, 2143.528423746773, 2155.1810312081307, 1764.9029303388309, 2065.8037486438766, 2070.3685375960326, 2075.740532433446, 2098.979010209909, 6806.76176333826, 6966.860662786716, 7446.739364122284, 7666.0, 7689.154193038761, 4637.327587499827, 4785.473597904228, 4788.688735232199, 4788.688735232234, 4789.616830653539, 2822.7459528642316, 2824.9852036426328, 2837.0495883878925, 2845.8616553378606, 2853.529167687329, 888.3692578269437, 894.5080205886736, 908.8227795579865, 922.1792604581927, 925.0841666749936, 10068.848967265423, 10114.9885011499, 10132.0, 10175.643852465202, 10237.9488102559, 3957.9010524737114, 4044.8584299549375, 4213.304804707189, 4230.492340919048, 4246.511651160156, 8638.913610863936, 8727.694530691395, 8739.12608739121, 8764.29096326223, 8770.38607297483, 4669.41632295963, 4675.392199014174, 4682.016776476978, 4691.695039822401, 4698.55363740451, 4227.957720422818, 4265.3601959705675, 4298.871033868989, 4299.441072660534, 4300.548442413564, 3582.2656355447593, 3603.387424137903, 3603.5315408997185, 3631.94552081719, 3700.259948010355, 1070.4968664727567, 1073.3988966178808, 1090.7872964771793, 1091.345192884279, 1137.0960086731068, 695.0824911117378, 722.6567380494223, 732.5385007445382, 844.966201351939, 882.4705176893813, 5160.690358578498, 5346.652467589594, 5364.946350536523, 5541.947030064275, 5556.388797232301, 874.4971641306274, 875.0287181228831, 884.1158841158841, 889.208604342136, 915.2952226785338, 3527.5943266524164, 3587.1032241939515, 3656.725745569093, 3684.797336146484, 3719.75821571597, 9587.472689002172, 9789.608415663437, 9876.259280553988, 9955.55200016001, 9966.2525310602, 8130.065042520067, 9091.772705682411, 9492.145706886413, 9857.162141218078, 9878.061584149495, 7351.0, 7524.962375188198, 7535.585542795199, 7536.886946695804, 7543.207963163899, 5473.06957817164, 5489.1217405214975, 5507.063799154073, 5570.470805273492, 5595.244641973444, 9033.638654453749, 9052.637894484147, 9065.274778017874, 9066.682666106655, 9096.499692516974, 8860.601272942604, 8935.776605584653, 9190.0, 9255.35212535143, 9265.44407335562, 6228.968855155696, 6286.874262514632, 6300.905486417799, 6367.713452894538, 6448.258450278278, 7273.309035641606, 7287.307705767944, 7302.306280903305, 7325.157606875277, 7334.449916256409, 6451.774187903401, 6601.669916504059, 6665.066890635412, 6677.666116694243, 6679.76620818269, 6450.870982580416, 6603.80188594343, 6656.73373065072, 6715.5299129060495, 6958.338957799001, 6601.768938087336, 6644.036614690746, 6656.7670131545165, 6666.333366663489, 6669.199696036507, 4445.955540444555, 4451.376807246923, 4540.772961351985, 4619.683390233768, 4650.534946505322, 4380.934285985776, 4404.185225733249, 4471.485779135311, 4486.528914464065, 4491.752953587454], "value": 4094.3373855002037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.95883055787465, 306.86191213953714, 310.5853685330084, 310.60863312226587, 311.1490074645845, 4832.83085092021, 4839.4918533554, 4840.588549973252, 4857.271409288608, 4860.829870954517, 4791.952080479195, 4796.376471058767, 4811.494793046732, 4837.467878533358, 4842.66101372904, 3639.1448009717697, 3717.275131349388, 3737.588865224823, 3840.3855383138703, 3872.2642697887454, 3805.1248212911046, 3806.7335286529956, 3809.371453710148, 3837.0239326746746, 3848.903777405559, 3584.623614520477, 3752.5684546277116, 3764.1906989997146, 3775.207206486641, 3788.495641531586, 3659.4876717259604, 3780.0738818989525, 3785.9242815143816, 3796.0, 3808.3525800613825, 3319.170207448138, 3334.1331253873923, 3346.1300061983816, 3355.966440335614, 3380.7126394256516, 4687.601553867926, 4715.528447155291, 4722.645801564897, 4723.0, 4736.171170045228, 4226.949929284295, 4297.699161058727, 4304.460368382669, 4335.263005289108, 4351.651867850596, 4958.801647934079, 4960.107180707471, 4968.503149685039, 4987.728129327034, 4997.50024997501, 3652.8721494747824, 3666.633336666339, 3671.7429779915415, 3682.3187710273687, 3684.778913265186, 5126.641135120543, 5154.484551544853, 5194.246834209019, 5235.921461178085, 5252.553532949704, 3721.3859713147026, 3730.962690373116, 3734.79458629778, 3743.5320584926885, 3777.867774627875, 3808.980955095207, 3812.9877396856173, 3823.388257878726, 3832.5017747693178, 3836.5204349456317, 4286.421333119989, 4295.52749197588, 4306.354046892991, 4314.9784251078545, 4315.4605674290715, 4883.682560633548, 4968.080905032581, 4979.05816731475, 4981.975090124526, 5002.1496345621335, 1291.109134697056, 1296.1380681846656, 1303.8305020347293, 1305.556110922291, 1310.351376068833, 859.458541119091, 868.8479516084786, 904.1997831918668, 932.3566738950103, 935.1863878425813, 4308.655307575386, 4317.287647538121, 4323.178596066738, 4326.372675961968, 4331.848385306499, 5056.6713163644245, 5067.569256613156, 5070.011347787146, 5083.110455670317, 5099.56653684441, 4134.400511925754, 4313.0, 4335.609795118391, 4338.349247612883, 4341.6526677865695, 2708.2552298118176, 2711.8508482033676, 2722.1561315992108, 2726.7273272672574, 2732.194002769188, 4789.3294938708605, 4847.491013443538, 4853.102176097434, 4856.271559266138, 4870.732109733928, 5005.799768009311, 5133.305014867225, 5168.8449346519665, 5173.741312934339, 5357.223202635596, 4877.12211801879, 4883.487233840467, 4902.0, 4905.681130726492, 4906.9263961040615, 5133.358330208724, 5156.871078223075, 5182.352205974254, 5184.0, 5198.558122559473, 4790.9281360780315, 5110.9233361500355, 5121.61587880903, 5126.487351264844, 5126.871828204325, 4891.682040667345, 4892.828750993841, 4915.11527924977, 4915.557599816034, 4919.163742163769, 3672.8163591819766, 3704.9444258336684, 3710.109573702346, 3714.7213958953726, 3734.3651579232137, 4964.032013757283, 5213.426523082534, 5225.790968361223, 5234.712090835041, 5262.605304602093, 5001.549860512571, 5028.195488721787, 5034.496550344937, 5038.874028149326, 5041.722705251246, 4997.425296090851, 5000.2999580058095, 5004.874878128076, 5059.544640982329, 5061.848144555669, 4724.267738500538, 4776.713397196179, 4958.38852372973, 4994.527708784175, 5027.49725027509, 4917.705137557917, 4983.800647974041, 5050.570701490415, 5056.595472362129, 5073.873153171053, 4941.258811178352, 4953.851384458472, 4962.230854217602, 4968.956519131023, 4970.726610036482], "value": 3807.744608564367, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.5184400635486, 605.2041565341575, 652.8694261147768, 666.4135560706579, 668.5387082912792, 13716.657083572916, 14434.5669629911, 14444.783328250085, 14455.999999999987, 14467.638309042266, 14994.250287485636, 15240.466583669573, 15241.237938103079, 15244.771328430055, 15261.923690381533, 701.2216439751884, 786.3944762532847, 788.3141666749935, 789.2541548236918, 790.2137373313561, 784.2588753627824, 794.3327604811957, 794.4041968523608, 794.4677066365549, 794.9284564389204, 837.660747397305, 840.2353857989231, 842.2461896602537, 842.9114942930966, 844.1937949258444, 834.862247729124, 836.7364280251732, 837.0750320895414, 837.5686521441462, 838.1409055717877, 609.3327806052409, 610.0879185617486, 613.5827637206697, 613.6594190224424, 614.8370681769335, 13802.930985345009, 13804.0, 13843.515476958259, 13847.376868040963, 13850.09974351674, 12634.74730505394, 12775.808362874564, 13080.738385232336, 13082.934585327108, 13247.337633118403, 10765.33137363702, 10835.783284334348, 10916.235863489559, 10931.836022459669, 11118.388488633122, 3295.6374798772117, 3296.653851345598, 3326.8170250636203, 3374.6456622054575, 3483.198864261234, 44412.55587444117, 47498.28752568714, 57786.99999999958, 57830.42169578335, 62128.37871621271, 9781.46201958885, 10055.44695041765, 10208.591656333812, 10239.232057595562, 10250.0, 19862.90068549648, 19990.90004549968, 20284.695729564068, 20303.695444568344, 20334.186632534827, 6810.114685091005, 7026.543274687231, 7042.647867606599, 7189.317014883578, 7255.8911616325795, 3753.49327840738, 3784.8675296364495, 3826.6747326477002, 3861.864834730771, 3939.881803545898, 2796.6644002719804, 2917.9708202918123, 2918.1537354167476, 2918.73731364174, 2921.5033444314518, 494.90844193824256, 499.3209235439799, 513.5352505982092, 515.2554558662696, 522.4984015345235, 571.5284889965795, 598.6767145741338, 610.8625559249133, 614.7110857896781, 625.1060982794647, 7803.297703206738, 7881.724139655084, 8012.559309238048, 8220.753377398687, 8290.8341833163, 559.9412061733459, 564.0101621653971, 573.6902072880681, 593.1073734030257, 598.5510866849862, 3842.6733727633464, 3858.4855718809063, 3915.451836742858, 3997.160596274815, 4011.217812526529, 54852.0, 56221.71889140528, 72200.63899680573, 100252.0, 100312.49843750881, 58889.41110588925, 73259.63370183115, 86634.56682716546, 88930.11069889218, 91938.54030729804, 75807.0, 77682.0, 79271.0, 79555.60222198852, 79965.85285957494, 7972.601369931364, 8090.474119182234, 8121.675132994614, 8144.877826832484, 8425.43921012129, 45670.771646141555, 46065.76967115143, 46086.769566151954, 46260.76869615765, 46604.7669761649, 62445.68777156085, 68342.31657683359, 68675.31324686689, 68809.65595171992, 68916.31083689099, 11348.54605815758, 11506.712332191762, 11535.134864885, 11733.413329333669, 11932.821007684717, 12380.752384952431, 12516.123871329284, 12543.3101179436, 12670.683232919251, 13068.21846179808, 11871.940640296743, 12145.149839511503, 12228.205166664138, 12251.0, 12403.93798031004, 10702.0, 11193.160512961398, 11280.830787538358, 11498.48256828428, 11572.305661660328, 11737.589184378507, 11745.060395168195, 11887.940560297144, 11957.940210298893, 11958.64124076279, 10347.541567872317, 10426.739331516772, 10676.306040107369, 10908.727281818017, 11316.20786544934, 9997.900020999698, 10164.971006458076, 10522.263441559018, 10548.367097974146, 10577.418241996764], "value": 6631.791150478804, "unit": "score"}], "name": "dromaeo_css", "value": 6481.896055013734, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 114.0, 116.0, 116.0, 116.0, 114.0, 115.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 126.0, 126.0, 184.0, 128.0, 124.0, 153.0, 122.0, 189.0, 123.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 161.0, 161.0, 161.0, 165.0, 161.0, 161.0, 164.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 108.0, 77.0, 78.0, 75.0, 77.0, 100.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 109.0, 84.0, 87.0, 85.0, 121.0, 84.0, 84.0, 129.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 157.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 62.0, 65.0, 64.0, 64.0, 64.0, 63.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 68.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 88.0, 78.0, 78.0, 78.0, 89.0, 79.0, 79.0, 85.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 132.0, 134.0, 128.0, 135.0, 126.0, 141.0, 127.0, 166.0, 135.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 163.0, 165.0, 167.0, 163.0, 162.0, 162.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 67.0, 66.0, 65.0, 66.0, 66.0, 64.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1532.4999999999998, "alertThreshold": 2.0}]} 20:57:35 INFO - Return code: 0 20:57:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:57:35 INFO - # TBPL SUCCESS # 20:57:35 INFO - Running post-action listener: _resource_record_post_action 20:57:35 INFO - ##### 20:57:35 INFO - ##### Finished run-tests step (success) 20:57:35 INFO - ##### 20:57:35 INFO - Running post-run listener: _resource_record_post_run 20:57:35 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 540672000; Read time: 80; Write time: 684148 20:57:35 INFO - TinderboxPrint: CPU usage
13.0% 20:57:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 80 20:57:35 INFO - TinderboxPrint: I/O write bytes / time
540,672,000 / 684,148 20:57:35 INFO - TinderboxPrint: CPU idle
8,329.6 (87.0%) 20:57:35 INFO - TinderboxPrint: CPU user
1,200.8 (12.5%) 20:57:35 INFO - TinderboxPrint: Swap in / out
0 / 0 20:57:35 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 252977152; Read time: 68; Write time: 399040 20:57:35 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 287080448; Read time: 0; Write time: 285108 20:57:35 INFO - Running post-run listener: _upload_blobber_files 20:57:35 INFO - Blob upload gear active. 20:57:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:57:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:57:35 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'] 20:57:35 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 20:57:36 INFO - (blobuploader) - INFO - Open directory for files ... 20:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:57:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:57:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:57:39 INFO - (blobuploader) - INFO - Done attempting. 20:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:57:40 INFO - (blobuploader) - INFO - Done attempting. 20:57:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:57:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:57:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:57:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:57:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:57:41 INFO - (blobuploader) - INFO - Done attempting. 20:57:41 INFO - (blobuploader) - INFO - Iteration through files over. 20:57:41 INFO - Return code: 0 20:57:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:57:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:57:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a05b64fafa7c0aa8123bed7c3e846327caaa79ed0a9d3a9b9d1990925f031589995c1a9b3b46d31af2e6177787a9057177cd12026448a4dfd1882a2fac70e1dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f5104f99bad58cc974c40fc659d8b807bffa66fda770ec4f06e25b0741c5abc5df5edf66bd137516071e51e7e42ea0aa0c36f0ca2f5b74f1f86c7be034172341", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2b383d8ffa382eacb015bfca3518018e2c2f54f6972719f18c1d355a67b3c04a2fb8c98b1760b58fc587e835336632057ddb493fd95412da2c5f765cc1afe163"} 20:57:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:57:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:57:41 INFO - Contents: 20:57:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a05b64fafa7c0aa8123bed7c3e846327caaa79ed0a9d3a9b9d1990925f031589995c1a9b3b46d31af2e6177787a9057177cd12026448a4dfd1882a2fac70e1dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f5104f99bad58cc974c40fc659d8b807bffa66fda770ec4f06e25b0741c5abc5df5edf66bd137516071e51e7e42ea0aa0c36f0ca2f5b74f1f86c7be034172341", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2b383d8ffa382eacb015bfca3518018e2c2f54f6972719f18c1d355a67b3c04a2fb8c98b1760b58fc587e835336632057ddb493fd95412da2c5f765cc1afe163"} 20:57:41 INFO - Running post-run listener: copy_logs_to_upload_dir 20:57:41 INFO - Copying logs to upload dir... 20:57:41 INFO - mkdir: /builds/slave/test/build/upload/logs 20:57:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.180737 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-19 20:57:40.708174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 20:57:40.711663) ========= 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=52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386 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/a05b64fafa7c0aa8123bed7c3e846327caaa79ed0a9d3a9b9d1990925f031589995c1a9b3b46d31af2e6177787a9057177cd12026448a4dfd1882a2fac70e1dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f5104f99bad58cc974c40fc659d8b807bffa66fda770ec4f06e25b0741c5abc5df5edf66bd137516071e51e7e42ea0aa0c36f0ca2f5b74f1f86c7be034172341", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2b383d8ffa382eacb015bfca3518018e2c2f54f6972719f18c1d355a67b3c04a2fb8c98b1760b58fc587e835336632057ddb493fd95412da2c5f765cc1afe163"} build_url:https://queue.taskcluster.net/v1/task/a_XgzBDeRYGXjjK15H2d4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/a_XgzBDeRYGXjjK15H2d4w/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/a05b64fafa7c0aa8123bed7c3e846327caaa79ed0a9d3a9b9d1990925f031589995c1a9b3b46d31af2e6177787a9057177cd12026448a4dfd1882a2fac70e1dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f5104f99bad58cc974c40fc659d8b807bffa66fda770ec4f06e25b0741c5abc5df5edf66bd137516071e51e7e42ea0aa0c36f0ca2f5b74f1f86c7be034172341", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2b383d8ffa382eacb015bfca3518018e2c2f54f6972719f18c1d355a67b3c04a2fb8c98b1760b58fc587e835336632057ddb493fd95412da2c5f765cc1afe163"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 20:57:40.737143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 20:57:40.737483) ========= 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=52faae308a556c440401f8e5000001e8-1468985820.542034-1825446386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004364 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 20:57:40.821036) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 20:57:40.821365) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 20:57:40.821656) ========= ========= Total master_lag: 0.14 =========